builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-040 starttime: 1494423498.72 results: success (0) revision: 8ad5338081026c48029d72f1e6c1668a58489bec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 06:38:18.724308) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 06:38:18.724788) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 06:38:18.725059) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 06:38:18.740870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 06:38:18.741293) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-10 06:38:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 54.6M=0s 2017-05-10 06:38:19 (54.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.078064 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 06:38:18.834999) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 06:38:18.835772) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017146 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 06:38:18.887501) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 06:38:18.887901) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8ad5338081026c48029d72f1e6c1668a58489bec --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 8ad5338081026c48029d72f1e6c1668a58489bec --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=9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-10 06:38:19,533 truncating revision to first 12 chars 2017-05-10 06:38:19,533 Setting DEBUG logging. 2017-05-10 06:38:19,533 attempt 1/10 2017-05-10 06:38:19,533 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8ad533808102?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-10 06:38:20,140 unpacking tar archive at: mozilla-central-8ad533808102/testing/mozharness/ program finished with exit code 0 elapsedTime=0.970401 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 06:38:19.872559) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 06:38:19.872947) ========= script_repo_revision: 8ad5338081026c48029d72f1e6c1668a58489bec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 06:38:19.873400) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 06:38:19.873776) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 06:38:19.886745) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-10 06:38:19.887244) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:38:20 INFO - MultiFileLogger online at 20170510 06:38:20 in /builds/slave/test 06:38:20 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:38:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:38:20 INFO - {'append_to_log': False, 06:38:20 INFO - 'base_work_dir': '/builds/slave/test', 06:38:20 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:38:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:38:20 INFO - 'branch': 'Firefox-Non-PGO', 06:38:20 INFO - 'buildbot_json_path': 'buildprops.json', 06:38:20 INFO - 'config_files': ('talos/linux_config.py',), 06:38:20 INFO - 'default_actions': ('clobber', 06:38:20 INFO - 'read-buildbot-config', 06:38:20 INFO - 'download-and-extract', 06:38:20 INFO - 'populate-webroot', 06:38:20 INFO - 'create-virtualenv', 06:38:20 INFO - 'install', 06:38:20 INFO - 'run-tests'), 06:38:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:38:20 INFO - 'download_minidump_stackwalk': True, 06:38:20 INFO - 'download_symbols': 'ondemand', 06:38:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:38:20 INFO - 'tooltool.py': '/tools/tooltool.py', 06:38:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:38:20 INFO - '/tools/misc-python/virtualenv.py')}, 06:38:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:38:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:38:20 INFO - 'gecko_profile': False, 06:38:20 INFO - 'gecko_profile_interval': 0, 06:38:20 INFO - 'installer_path': 'installer.exe', 06:38:20 INFO - 'log_level': 'info', 06:38:20 INFO - 'log_name': 'talos', 06:38:20 INFO - 'log_to_console': True, 06:38:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:38:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:38:20 INFO - 'opt_config_files': (), 06:38:20 INFO - 'pip_index': False, 06:38:20 INFO - 'suite': 'dromaeojs-e10s', 06:38:20 INFO - 'system_bits': '32', 06:38:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:38:20 INFO - 'title': 'talos-linux64-ix-040', 06:38:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:38:20 INFO - 'use_talos_json': True, 06:38:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:38:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:38:20 INFO - 'work_dir': 'build'} 06:38:20 INFO - [mozharness: 2017-05-10 13:38:20.638905Z] Running clobber step. 06:38:20 INFO - Running pre-action listener: _resource_record_pre_action 06:38:20 INFO - Running main action method: clobber 06:38:20 INFO - rmtree: /builds/slave/test/build 06:38:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:38:22 INFO - Running post-action listener: _resource_record_post_action 06:38:22 INFO - [mozharness: 2017-05-10 13:38:22.120967Z] Finished clobber step (success) 06:38:22 INFO - [mozharness: 2017-05-10 13:38:22.121065Z] Running read-buildbot-config step. 06:38:22 INFO - Running pre-action listener: _resource_record_pre_action 06:38:22 INFO - Running main action method: read_buildbot_config 06:38:22 INFO - Using buildbot properties: 06:38:22 INFO - { 06:38:22 INFO - "project": "", 06:38:22 INFO - "product": "firefox", 06:38:22 INFO - "who": "cbook@mozilla.com", 06:38:22 INFO - "installer_path": "public/build/target.tar.bz2", 06:38:22 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:38:22 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:38:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 06:38:22 INFO - "stage_platform": "linux64", 06:38:22 INFO - "basedir": "/builds/slave/test", 06:38:22 INFO - "buildnumber": 866, 06:38:22 INFO - "platform": "ubuntu64_hw", 06:38:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:38:22 INFO - "slavebuilddir": "test", 06:38:22 INFO - "taskId": "T9yqLNdGQM2Xqj1_oP63Tw", 06:38:22 INFO - "branch": "mozilla-central", 06:38:22 INFO - "script_repo_revision": "production", 06:38:22 INFO - "revision": "8ad5338081026c48029d72f1e6c1668a58489bec", 06:38:22 INFO - "slavename": "talos-linux64-ix-040", 06:38:22 INFO - "repo_path": "mozilla-central" 06:38:22 INFO - } 06:38:22 INFO - Finding installer, test and symbols from parent task. 06:38:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T9yqLNdGQM2Xqj1_oP63Tw'}, attempt #1 06:38:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T9yqLNdGQM2Xqj1_oP63Tw'}, attempt #1 06:38:23 INFO - Task dependencies: C-8W5w8iT-ikMnRjWDqBYQ 06:38:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ'}, attempt #1 06:38:23 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.tar.bz2 06:38:23 INFO - Set test_url: https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/test_packages.json 06:38:23 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.crashreporter-symbols.zip 06:38:23 INFO - Running post-action listener: _resource_record_post_action 06:38:23 INFO - [mozharness: 2017-05-10 13:38:23.480929Z] Finished read-buildbot-config step (success) 06:38:23 INFO - [mozharness: 2017-05-10 13:38:23.481143Z] Running download-and-extract step. 06:38:23 INFO - Running pre-action listener: _resource_record_pre_action 06:38:23 INFO - Running main action method: download_and_extract 06:38:23 INFO - mkdir: /builds/slave/test/build/tests 06:38:23 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:38:23 INFO - trying https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.test_packages.json 06:38:23 INFO - Downloading https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:38:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:38:24 INFO - Downloaded 986 bytes. 06:38:24 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:38:24 INFO - Using the following test package requirements: 06:38:24 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:38:24 INFO - u'common': [u'target.common.tests.zip'], 06:38:24 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:38:24 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:38:24 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:38:24 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:38:24 INFO - u'mozbase': [u'target.common.tests.zip'], 06:38:24 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:38:24 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:38:24 INFO - u'web-platform': [u'target.common.tests.zip', 06:38:24 INFO - u'target.web-platform.tests.zip'], 06:38:24 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:38:24 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:38:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.common.tests.zip 06:38:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:38:24 INFO - Fetch https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.common.tests.zip into memory 06:38:25 INFO - Content-Length response header: 58446126 06:38:25 INFO - Bytes received: 58446126 06:38:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:38:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.common.tests.zip 06:38:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:38:34 INFO - Fetch https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.common.tests.zip into memory 06:38:36 INFO - Content-Length response header: 58446126 06:38:36 INFO - Bytes received: 58446126 06:38:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.talos.tests.zip 06:38:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:38:46 INFO - Fetch https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.talos.tests.zip into memory 06:38:47 INFO - Content-Length response header: 14409362 06:38:47 INFO - Bytes received: 14409362 06:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:47 INFO - trying https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.tar.bz2 06:38:47 INFO - Downloading https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:38:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:38:48 INFO - Downloaded 62982752 bytes. 06:38:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.tar.bz2 06:38:48 INFO - mkdir: /builds/slave/test/properties 06:38:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:38:48 INFO - Writing to file /builds/slave/test/properties/build_url 06:38:48 INFO - Contents: 06:38:48 INFO - build_url:https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.tar.bz2 06:38:48 INFO - Running post-action listener: _resource_record_post_action 06:38:48 INFO - Running post-action listener: set_extra_try_arguments 06:38:48 INFO - [mozharness: 2017-05-10 13:38:48.853374Z] Finished download-and-extract step (success) 06:38:48 INFO - [mozharness: 2017-05-10 13:38:48.853470Z] Running populate-webroot step. 06:38:48 INFO - Running pre-action listener: _resource_record_pre_action 06:38:48 INFO - Running main action method: populate_webroot 06:38:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:38:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:38:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:38:48 INFO - '--tppagecycles', 06:38:48 INFO - '7'], 06:38:48 INFO - 'tests': ['tsvgm']}}, 06:38:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:38:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:38:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:38:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:38:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:38:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:38:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:38:48 INFO - 'talos_options': ['--disable-e10s'], 06:38:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:38:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:38:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:38:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:38:48 INFO - 'talos_options': ['--disable-e10s'], 06:38:48 INFO - 'tests': ['damp', 'tps']}, 06:38:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:38:48 INFO - 'tests': ['damp', 'tps']}, 06:38:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:38:48 INFO - 'tests': ['dromaeo_dom']}, 06:38:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:38:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:38:48 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:38:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:38:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:38:48 INFO - 'tests': ['a11yr', 06:38:48 INFO - 'ts_paint', 06:38:48 INFO - 'tpaint', 06:38:48 INFO - 'sessionrestore', 06:38:48 INFO - 'sessionrestore_no_auto_restore', 06:38:48 INFO - 'tabpaint']}, 06:38:48 INFO - 'other-e10s': {'tests': ['a11yr', 06:38:48 INFO - 'ts_paint', 06:38:48 INFO - 'tpaint', 06:38:48 INFO - 'sessionrestore', 06:38:48 INFO - 'sessionrestore_no_auto_restore', 06:38:48 INFO - 'tabpaint']}, 06:38:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:38:48 INFO - 'ts_paint', 06:38:48 INFO - 'tpaint', 06:38:48 INFO - 'sessionrestore', 06:38:48 INFO - 'sessionrestore_no_auto_restore', 06:38:48 INFO - 'tabpaint']}, 06:38:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:38:48 INFO - 'ts_paint', 06:38:48 INFO - 'tpaint', 06:38:48 INFO - 'sessionrestore', 06:38:48 INFO - 'sessionrestore_no_auto_restore', 06:38:48 INFO - 'tabpaint']}, 06:38:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:38:48 INFO - 'tests': ['a11yr', 06:38:48 INFO - 'ts_paint', 06:38:48 INFO - 'tpaint', 06:38:48 INFO - 'sessionrestore', 06:38:48 INFO - 'sessionrestore_no_auto_restore', 06:38:48 INFO - 'tabpaint']}, 06:38:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:38:48 INFO - 'tests': ['a11yr', 06:38:48 INFO - 'ts_paint', 06:38:48 INFO - 'tpaint', 06:38:48 INFO - 'sessionrestore', 06:38:48 INFO - 'sessionrestore_no_auto_restore', 06:38:48 INFO - 'tabpaint']}, 06:38:48 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 06:38:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 06:38:48 INFO - 'bloom_basic_ref']}, 06:38:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:38:48 INFO - 'tests': ['tsvgx', 06:38:48 INFO - 'tsvgr_opacity', 06:38:48 INFO - 'tart', 06:38:48 INFO - 'tscrollx', 06:38:48 INFO - 'cart', 06:38:48 INFO - 'tsvg_static']}, 06:38:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:38:48 INFO - 'tsvgr_opacity', 06:38:48 INFO - 'tart', 06:38:48 INFO - 'tscrollx', 06:38:48 INFO - 'cart', 06:38:48 INFO - 'tsvg_static']}, 06:38:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:38:48 INFO - 'talos_options': ['--disable-e10s'], 06:38:48 INFO - 'tests': ['tp5o']}, 06:38:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:38:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:38:48 INFO - 'talos_options': ['--disable-e10s', 06:38:48 INFO - '--xperf_path', 06:38:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:38:48 INFO - 'tests': ['tp5n']}, 06:38:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:38:48 INFO - 'talos_options': ['--xperf_path', 06:38:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:38:48 INFO - 'tests': ['tp5n']}}, 06:38:48 INFO - 'talos.zip': {'path': '', 06:38:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:38:48 INFO - Running post-action listener: _resource_record_post_action 06:38:48 INFO - [mozharness: 2017-05-10 13:38:48.866938Z] Finished populate-webroot step (success) 06:38:48 INFO - [mozharness: 2017-05-10 13:38:48.867026Z] Running create-virtualenv step. 06:38:48 INFO - Running pre-action listener: _resource_record_pre_action 06:38:48 INFO - Running main action method: create_virtualenv 06:38:48 INFO - Creating virtualenv /builds/slave/test/build/venv 06:38:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:38:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:38:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:38:48 INFO - Using real prefix '/usr' 06:38:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:38:49 INFO - Installing distribute.............................................................................................................................................................................................done. 06:38:51 INFO - Installing pip.................done. 06:38:51 INFO - Return code: 0 06:38:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:38:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:38:51 INFO - Reading from file tmpfile_stdout 06:38:51 INFO - Output received: 06:38:51 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:38:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2302a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a5a30>, '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 0x24a67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a6ca0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429', '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:38:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:38:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:38:51 INFO - Using env: {'DISPLAY': ':0', 06:38:51 INFO - 'HOME': '/home/cltbld', 06:38:51 INFO - 'LANG': 'en_US.UTF-8', 06:38:51 INFO - 'LANGUAGE': 'en_US:en', 06:38:51 INFO - 'LOGNAME': 'cltbld', 06:38:51 INFO - 'MAIL': '/var/mail/cltbld', 06:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:51 INFO - 'MOZ_NO_REMOTE': '1', 06:38:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:51 INFO - 'NO_EM_RESTART': '1', 06:38:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:51 INFO - 'PWD': '/builds/slave/test', 06:38:51 INFO - 'SHELL': '/bin/bash', 06:38:51 INFO - 'SHLVL': '1', 06:38:51 INFO - 'TERM': 'linux', 06:38:51 INFO - 'TMOUT': '86400', 06:38:51 INFO - 'USER': 'cltbld', 06:38:51 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429', 06:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:51 INFO - '_': '/tools/buildbot/bin/python'} 06:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:38:51 INFO - Cleaning up... 06:38:51 INFO - Return code: 0 06:38:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2302a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a5a30>, '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 0x24a67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a6ca0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429', '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:38:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:38:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:38:51 INFO - Using env: {'DISPLAY': ':0', 06:38:51 INFO - 'HOME': '/home/cltbld', 06:38:51 INFO - 'LANG': 'en_US.UTF-8', 06:38:51 INFO - 'LANGUAGE': 'en_US:en', 06:38:51 INFO - 'LOGNAME': 'cltbld', 06:38:51 INFO - 'MAIL': '/var/mail/cltbld', 06:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:51 INFO - 'MOZ_NO_REMOTE': '1', 06:38:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:51 INFO - 'NO_EM_RESTART': '1', 06:38:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:51 INFO - 'PWD': '/builds/slave/test', 06:38:51 INFO - 'SHELL': '/bin/bash', 06:38:51 INFO - 'SHLVL': '1', 06:38:51 INFO - 'TERM': 'linux', 06:38:51 INFO - 'TMOUT': '86400', 06:38:51 INFO - 'USER': 'cltbld', 06:38:51 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429', 06:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:51 INFO - '_': '/tools/buildbot/bin/python'} 06:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:52 INFO - Downloading/unpacking psutil>=3.1.1 06:38:52 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:38:52 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:38:52 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:38:52 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:38:52 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:38:52 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:38:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:38:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:38:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:38:53 INFO - Installing collected packages: psutil 06:38:53 INFO - Running setup.py install for psutil 06:38:53 INFO - building 'psutil._psutil_linux' extension 06:38:53 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:38:53 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:38:53 INFO - building 'psutil._psutil_posix' extension 06:38:53 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:38:53 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:38:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:38:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:38:53 INFO - Successfully installed psutil 06:38:53 INFO - Cleaning up... 06:38:53 INFO - Return code: 0 06:38:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:38:53 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:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:53 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:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:53 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 0x21361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2302a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a5a30>, '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 0x24a67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a6ca0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429', '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:38:53 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:38:53 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:38:53 INFO - Using env: {'DISPLAY': ':0', 06:38:53 INFO - 'HOME': '/home/cltbld', 06:38:53 INFO - 'LANG': 'en_US.UTF-8', 06:38:53 INFO - 'LANGUAGE': 'en_US:en', 06:38:53 INFO - 'LOGNAME': 'cltbld', 06:38:53 INFO - 'MAIL': '/var/mail/cltbld', 06:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:53 INFO - 'MOZ_NO_REMOTE': '1', 06:38:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:53 INFO - 'NO_EM_RESTART': '1', 06:38:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:53 INFO - 'PWD': '/builds/slave/test', 06:38:53 INFO - 'SHELL': '/bin/bash', 06:38:53 INFO - 'SHLVL': '1', 06:38:53 INFO - 'TERM': 'linux', 06:38:53 INFO - 'TMOUT': '86400', 06:38:53 INFO - 'USER': 'cltbld', 06:38:53 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429', 06:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:53 INFO - '_': '/tools/buildbot/bin/python'} 06:38:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:38:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:38:55 INFO - Installing collected packages: mozsystemmonitor 06:38:55 INFO - Running setup.py install for mozsystemmonitor 06:38:55 INFO - Successfully installed mozsystemmonitor 06:38:55 INFO - Cleaning up... 06:38:55 INFO - Return code: 0 06:38:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:38: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:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38: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:38:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:55 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 0x21361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2302a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a5a30>, '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 0x24a67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a6ca0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429', '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:38:55 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:38:55 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:38:55 INFO - Using env: {'DISPLAY': ':0', 06:38:55 INFO - 'HOME': '/home/cltbld', 06:38:55 INFO - 'LANG': 'en_US.UTF-8', 06:38:55 INFO - 'LANGUAGE': 'en_US:en', 06:38:55 INFO - 'LOGNAME': 'cltbld', 06:38:55 INFO - 'MAIL': '/var/mail/cltbld', 06:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:55 INFO - 'MOZ_NO_REMOTE': '1', 06:38:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:55 INFO - 'NO_EM_RESTART': '1', 06:38:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:55 INFO - 'PWD': '/builds/slave/test', 06:38:55 INFO - 'SHELL': '/bin/bash', 06:38:55 INFO - 'SHLVL': '1', 06:38:55 INFO - 'TERM': 'linux', 06:38:55 INFO - 'TMOUT': '86400', 06:38:55 INFO - 'USER': 'cltbld', 06:38:55 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429', 06:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:55 INFO - '_': '/tools/buildbot/bin/python'} 06:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:55 INFO - Downloading/unpacking jsonschema==2.5.1 06:38:55 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:38:55 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:38:55 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:38:55 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:38:55 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:38:55 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:38:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:38:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:56 INFO - Downloading functools32-3.2.3-2.tar.gz 06:38:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:38:56 INFO - warning: no files found matching '*.txt' 06:38:56 INFO - no previously-included directories found matching 'build' 06:38:56 INFO - no previously-included directories found matching 'dist' 06:38:56 INFO - no previously-included directories found matching '.git*' 06:38:56 INFO - Installing collected packages: jsonschema, functools32 06:38:56 INFO - Running setup.py install for functools32 06:38:56 INFO - warning: no files found matching '*.txt' 06:38:56 INFO - no previously-included directories found matching 'build' 06:38:56 INFO - no previously-included directories found matching 'dist' 06:38:56 INFO - no previously-included directories found matching '.git*' 06:38:57 INFO - Successfully installed jsonschema functools32 06:38:57 INFO - Cleaning up... 06:38:57 INFO - Return code: 0 06:38:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:38:57 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:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:57 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:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:57 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 0x21361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2302a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a5a30>, '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 0x24a67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a6ca0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429', '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:38:57 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:38:57 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:38:57 INFO - Using env: {'DISPLAY': ':0', 06:38:57 INFO - 'HOME': '/home/cltbld', 06:38:57 INFO - 'LANG': 'en_US.UTF-8', 06:38:57 INFO - 'LANGUAGE': 'en_US:en', 06:38:57 INFO - 'LOGNAME': 'cltbld', 06:38:57 INFO - 'MAIL': '/var/mail/cltbld', 06:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:57 INFO - 'MOZ_NO_REMOTE': '1', 06:38:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:57 INFO - 'NO_EM_RESTART': '1', 06:38:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:57 INFO - 'PWD': '/builds/slave/test', 06:38:57 INFO - 'SHELL': '/bin/bash', 06:38:57 INFO - 'SHLVL': '1', 06:38:57 INFO - 'TERM': 'linux', 06:38:57 INFO - 'TMOUT': '86400', 06:38:57 INFO - 'USER': 'cltbld', 06:38:57 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429', 06:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:57 INFO - '_': '/tools/buildbot/bin/python'} 06:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:38:57 INFO - Cleaning up... 06:38:57 INFO - Return code: 0 06:38:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:38:57 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:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:57 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:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:57 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 0x21361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2302a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a5a30>, '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 0x24a67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a6ca0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429', '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:38:57 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:38:57 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:38:57 INFO - Using env: {'DISPLAY': ':0', 06:38:57 INFO - 'HOME': '/home/cltbld', 06:38:57 INFO - 'LANG': 'en_US.UTF-8', 06:38:57 INFO - 'LANGUAGE': 'en_US:en', 06:38:57 INFO - 'LOGNAME': 'cltbld', 06:38:57 INFO - 'MAIL': '/var/mail/cltbld', 06:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:57 INFO - 'MOZ_NO_REMOTE': '1', 06:38:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:57 INFO - 'NO_EM_RESTART': '1', 06:38:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:57 INFO - 'PWD': '/builds/slave/test', 06:38:57 INFO - 'SHELL': '/bin/bash', 06:38:57 INFO - 'SHLVL': '1', 06:38:57 INFO - 'TERM': 'linux', 06:38:57 INFO - 'TMOUT': '86400', 06:38:57 INFO - 'USER': 'cltbld', 06:38:57 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429', 06:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:57 INFO - '_': '/tools/buildbot/bin/python'} 06:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:57 INFO - Downloading/unpacking blobuploader==1.2.4 06:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:58 INFO - Downloading blobuploader-1.2.4.tar.gz 06:38:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:38:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:38:58 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:38:58 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:38:58 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:38:58 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:38:58 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:38:58 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:38:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:38:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:59 INFO - Downloading docopt-0.6.1.tar.gz 06:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:38:59 INFO - Installing collected packages: blobuploader, requests, docopt 06:38:59 INFO - Running setup.py install for blobuploader 06:38:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:38:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:38:59 INFO - Running setup.py install for requests 06:38:59 INFO - Running setup.py install for docopt 06:38:59 INFO - Successfully installed blobuploader requests docopt 06:38:59 INFO - Cleaning up... 06:38:59 INFO - Return code: 0 06:38:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:38: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:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38: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:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:59 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 0x21361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2302a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a5a30>, '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 0x24a67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a6ca0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429', '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:38:59 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:38:59 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:38:59 INFO - Using env: {'DISPLAY': ':0', 06:38:59 INFO - 'HOME': '/home/cltbld', 06:38:59 INFO - 'LANG': 'en_US.UTF-8', 06:38:59 INFO - 'LANGUAGE': 'en_US:en', 06:38:59 INFO - 'LOGNAME': 'cltbld', 06:38:59 INFO - 'MAIL': '/var/mail/cltbld', 06:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:59 INFO - 'MOZ_NO_REMOTE': '1', 06:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:59 INFO - 'NO_EM_RESTART': '1', 06:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:59 INFO - 'PWD': '/builds/slave/test', 06:38:59 INFO - 'SHELL': '/bin/bash', 06:38:59 INFO - 'SHLVL': '1', 06:38:59 INFO - 'TERM': 'linux', 06:38:59 INFO - 'TMOUT': '86400', 06:38:59 INFO - 'USER': 'cltbld', 06:38:59 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429', 06:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:59 INFO - '_': '/tools/buildbot/bin/python'} 06:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:39:00 INFO - Running setup.py (path:/tmp/pip-Z2BX9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:39:00 INFO - Running setup.py (path:/tmp/pip-ZTr5dW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:39:00 INFO - Running setup.py (path:/tmp/pip-UP_Vvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:39:00 INFO - Running setup.py (path:/tmp/pip-8cQlMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:39:00 INFO - Running setup.py (path:/tmp/pip-OuznPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:39:00 INFO - Running setup.py (path:/tmp/pip-pyxtxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:39:00 INFO - Running setup.py (path:/tmp/pip-EeLGmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:39:00 INFO - Running setup.py (path:/tmp/pip-02C0sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:39:00 INFO - Running setup.py (path:/tmp/pip-mCWrKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:39:00 INFO - Running setup.py (path:/tmp/pip-ASXak0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:39:00 INFO - Running setup.py (path:/tmp/pip-ejAxZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:39:00 INFO - Running setup.py (path:/tmp/pip-Ucz1V8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:39:00 INFO - Running setup.py (path:/tmp/pip-tHHMHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:39:00 INFO - Running setup.py (path:/tmp/pip-PNhZPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:01 INFO - Running setup.py (path:/tmp/pip-PkR4KY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:39:01 INFO - Running setup.py (path:/tmp/pip-U_fzGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:39:01 INFO - Running setup.py (path:/tmp/pip-JH2LK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:39:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:39:01 INFO - Running setup.py install for manifestparser 06:39:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:39:01 INFO - Running setup.py install for mozcrash 06:39:01 INFO - Running setup.py install for mozdebug 06:39:01 INFO - Running setup.py install for mozdevice 06:39:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:39:01 INFO - Running setup.py install for mozfile 06:39:01 INFO - Running setup.py install for mozhttpd 06:39:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:39:01 INFO - Running setup.py install for mozinfo 06:39:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:39:01 INFO - Running setup.py install for mozInstall 06:39:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:39:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:39:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:39:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:39:02 INFO - Running setup.py install for mozleak 06:39:02 INFO - Running setup.py install for mozlog 06:39:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:39:02 INFO - Running setup.py install for moznetwork 06:39:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:39:02 INFO - Running setup.py install for mozprocess 06:39:02 INFO - Running setup.py install for mozprofile 06:39:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:39:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:39:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:39:02 INFO - Running setup.py install for mozrunner 06:39:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:39:02 INFO - Running setup.py install for mozscreenshot 06:39:02 INFO - Running setup.py install for moztest 06:39:02 INFO - Running setup.py install for mozversion 06:39:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:39:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:39:03 INFO - Cleaning up... 06:39:03 INFO - Return code: 0 06:39:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:39: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:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39: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:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:03 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 0x21361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2302a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a5a30>, '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 0x24a67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a6ca0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429', '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:39:03 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:39:03 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:39:03 INFO - Using env: {'DISPLAY': ':0', 06:39:03 INFO - 'HOME': '/home/cltbld', 06:39:03 INFO - 'LANG': 'en_US.UTF-8', 06:39:03 INFO - 'LANGUAGE': 'en_US:en', 06:39:03 INFO - 'LOGNAME': 'cltbld', 06:39:03 INFO - 'MAIL': '/var/mail/cltbld', 06:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:03 INFO - 'MOZ_NO_REMOTE': '1', 06:39:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:03 INFO - 'NO_EM_RESTART': '1', 06:39:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:03 INFO - 'PWD': '/builds/slave/test', 06:39:03 INFO - 'SHELL': '/bin/bash', 06:39:03 INFO - 'SHLVL': '1', 06:39:03 INFO - 'TERM': 'linux', 06:39:03 INFO - 'TMOUT': '86400', 06:39:03 INFO - 'USER': 'cltbld', 06:39:03 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429', 06:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:03 INFO - '_': '/tools/buildbot/bin/python'} 06:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:39:03 INFO - Running setup.py (path:/tmp/pip-igPlBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:39:03 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:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:39:03 INFO - Running setup.py (path:/tmp/pip-318lup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:39:03 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:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:39:03 INFO - Running setup.py (path:/tmp/pip-62ICCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:39:03 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:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:39:03 INFO - Running setup.py (path:/tmp/pip-EFC3Ge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:39:03 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:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:39:03 INFO - Running setup.py (path:/tmp/pip-TYjDvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:39:03 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:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:39:03 INFO - Running setup.py (path:/tmp/pip-smaUqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:39:03 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:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:39:03 INFO - Running setup.py (path:/tmp/pip-H1PNw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:39:03 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:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:39:03 INFO - Running setup.py (path:/tmp/pip-uYKO7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:39:03 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:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:39:03 INFO - Running setup.py (path:/tmp/pip-9tW400-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:39:03 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:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:39:03 INFO - Running setup.py (path:/tmp/pip-WOXpzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:39:04 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:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:39:04 INFO - Running setup.py (path:/tmp/pip-2g7QzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:39:04 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:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:39:04 INFO - Running setup.py (path:/tmp/pip-_ge050-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:39:04 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:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:39:04 INFO - Running setup.py (path:/tmp/pip-wmxNnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:39:04 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:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:39:04 INFO - Running setup.py (path:/tmp/pip-JV3_wH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:39:04 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:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:04 INFO - Running setup.py (path:/tmp/pip-AbLPsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:04 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:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:39:04 INFO - Running setup.py (path:/tmp/pip-GIgrj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:39:04 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:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:39:04 INFO - Running setup.py (path:/tmp/pip-NqluXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:39:04 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:39:04 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:39:04 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:39:04 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:39:04 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:39:04 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:39:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:39: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:39: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:39: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:39: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:39: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:39: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:39:05 INFO - Downloading blessings-1.6.tar.gz 06:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:39:05 INFO - Installing collected packages: blessings 06:39:05 INFO - Running setup.py install for blessings 06:39:05 INFO - Successfully installed blessings 06:39:05 INFO - Cleaning up... 06:39:05 INFO - Return code: 0 06:39:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:39:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:39:06 INFO - Reading from file tmpfile_stdout 06:39:06 INFO - Current package versions: 06:39:06 INFO - argparse == 1.2.1 06:39:06 INFO - blessings == 1.6 06:39:06 INFO - blobuploader == 1.2.4 06:39:06 INFO - docopt == 0.6.1 06:39:06 INFO - functools32 == 3.2.3-2 06:39:06 INFO - jsonschema == 2.5.1 06:39:06 INFO - manifestparser == 1.1 06:39:06 INFO - mozInstall == 1.12 06:39:06 INFO - mozcrash == 1.0 06:39:06 INFO - mozdebug == 0.1 06:39:06 INFO - mozdevice == 0.50 06:39:06 INFO - mozfile == 1.2 06:39:06 INFO - mozhttpd == 0.7 06:39:06 INFO - mozinfo == 0.9 06:39:06 INFO - mozleak == 0.1 06:39:06 INFO - mozlog == 3.4 06:39:06 INFO - moznetwork == 0.27 06:39:06 INFO - mozprocess == 0.25 06:39:06 INFO - mozprofile == 0.28 06:39:06 INFO - mozrunner == 6.13 06:39:06 INFO - mozscreenshot == 0.1 06:39:06 INFO - mozsystemmonitor == 0.3 06:39:06 INFO - moztest == 0.8 06:39:06 INFO - mozversion == 1.4 06:39:06 INFO - psutil == 3.1.1 06:39:06 INFO - requests == 1.2.3 06:39:06 INFO - wsgiref == 0.1.2 06:39:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:06 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 0x21361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2302a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a5a30>, '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 0x24a67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a6ca0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429', '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:39:06 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:39:06 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:39:06 INFO - Using env: {'DISPLAY': ':0', 06:39:06 INFO - 'HOME': '/home/cltbld', 06:39:06 INFO - 'LANG': 'en_US.UTF-8', 06:39:06 INFO - 'LANGUAGE': 'en_US:en', 06:39:06 INFO - 'LOGNAME': 'cltbld', 06:39:06 INFO - 'MAIL': '/var/mail/cltbld', 06:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:06 INFO - 'MOZ_NO_REMOTE': '1', 06:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:06 INFO - 'NO_EM_RESTART': '1', 06:39:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:06 INFO - 'PWD': '/builds/slave/test', 06:39:06 INFO - 'SHELL': '/bin/bash', 06:39:06 INFO - 'SHLVL': '1', 06:39:06 INFO - 'TERM': 'linux', 06:39:06 INFO - 'TMOUT': '86400', 06:39:06 INFO - 'USER': 'cltbld', 06:39:06 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429', 06:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:06 INFO - '_': '/tools/buildbot/bin/python'} 06:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:06 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:39:06 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:39:06 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:39:06 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:39:06 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:39:06 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:39:06 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:39:06 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:39:06 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:39:06 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:39:06 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:39:06 INFO - Cleaning up... 06:39:06 INFO - Return code: 0 06:39:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2302a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a5a30>, '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 0x24a67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a6ca0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429', '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:39:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:39:06 INFO - Using env: {'DISPLAY': ':0', 06:39:06 INFO - 'HOME': '/home/cltbld', 06:39:06 INFO - 'LANG': 'en_US.UTF-8', 06:39:06 INFO - 'LANGUAGE': 'en_US:en', 06:39:06 INFO - 'LOGNAME': 'cltbld', 06:39:06 INFO - 'MAIL': '/var/mail/cltbld', 06:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:06 INFO - 'MOZ_NO_REMOTE': '1', 06:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:06 INFO - 'NO_EM_RESTART': '1', 06:39:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:06 INFO - 'PWD': '/builds/slave/test', 06:39:06 INFO - 'SHELL': '/bin/bash', 06:39:06 INFO - 'SHLVL': '1', 06:39:06 INFO - 'TERM': 'linux', 06:39:06 INFO - 'TMOUT': '86400', 06:39:06 INFO - 'USER': 'cltbld', 06:39:06 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429', 06:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:06 INFO - '_': '/tools/buildbot/bin/python'} 06:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:39:06 INFO - Cleaning up... 06:39:06 INFO - Return code: 0 06:39:06 INFO - Running post-action listener: _resource_record_post_action 06:39:06 INFO - Running post-action listener: _start_resource_monitoring 06:39:06 INFO - Starting resource monitoring. 06:39:06 INFO - [mozharness: 2017-05-10 13:39:06.566153Z] Finished create-virtualenv step (success) 06:39:06 INFO - [mozharness: 2017-05-10 13:39:06.566663Z] Running install step. 06:39:06 INFO - Running pre-action listener: _resource_record_pre_action 06:39:06 INFO - Running main action method: install 06:39:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:39:06 INFO - Reading from file tmpfile_stdout 06:39:06 INFO - Detecting whether we're running mozinstall >=1.0... 06:39:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:39:06 INFO - Reading from file tmpfile_stdout 06:39:06 INFO - Output received: 06:39:06 INFO - Usage: mozinstall [options] installer 06:39:06 INFO - Options: 06:39:06 INFO - -h, --help show this help message and exit 06:39:06 INFO - -d DEST, --destination=DEST 06:39:06 INFO - Directory to install application into. [default: 06:39:06 INFO - "/builds/slave/test"] 06:39:06 INFO - --app=APP Application being installed. [default: firefox] 06:39:06 INFO - mkdir: /builds/slave/test/build/application 06:39:06 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:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:39:22 INFO - Reading from file tmpfile_stdout 06:39:22 INFO - Output received: 06:39:22 INFO - /builds/slave/test/build/application/firefox/firefox 06:39:22 INFO - Running post-action listener: _resource_record_post_action 06:39:22 INFO - [mozharness: 2017-05-10 13:39:22.635586Z] Finished install step (success) 06:39:22 INFO - [mozharness: 2017-05-10 13:39:22.635858Z] Running run-tests step. 06:39:22 INFO - Running pre-action listener: _resource_record_pre_action 06:39:22 INFO - Running main action method: run_tests 06:39:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:39:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:39:22 INFO - Python 2.7.3 06:39:22 INFO - Return code: 0 06:39:22 INFO - grabbing minidump binary from tooltool 06:39:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:22 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 0x24a5a30>, '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 0x24a67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a6ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:39:22 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:39:22 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:39:22 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:39:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:39:22 INFO - Return code: 0 06:39:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:39:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:39:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:39:22 INFO - ENV: RUST_BACKTRACE is now 1 06:39:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:39:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:39:22 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/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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:39:22 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/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-040 --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:39:22 INFO - Using env: {'DISPLAY': ':0', 06:39:22 INFO - 'HOME': '/home/cltbld', 06:39:22 INFO - 'LANG': 'en_US.UTF-8', 06:39:22 INFO - 'LANGUAGE': 'en_US:en', 06:39:22 INFO - 'LOGNAME': 'cltbld', 06:39:22 INFO - 'MAIL': '/var/mail/cltbld', 06:39:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:39:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:39:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:22 INFO - 'MOZ_NO_REMOTE': '1', 06:39:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:39:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:22 INFO - 'NO_EM_RESTART': '1', 06:39:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:22 INFO - 'PWD': '/builds/slave/test', 06:39:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:39:22 INFO - 'RUST_BACKTRACE': '1', 06:39:22 INFO - 'SHELL': '/bin/bash', 06:39:22 INFO - 'SHLVL': '1', 06:39:22 INFO - 'TERM': 'linux', 06:39:22 INFO - 'TMOUT': '86400', 06:39:22 INFO - 'USER': 'cltbld', 06:39:22 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429', 06:39:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:22 INFO - '_': '/tools/buildbot/bin/python'} 06:39:22 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/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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:39:22 INFO - mozversion application_buildid: 20170510130637 06:39:22 INFO - mozversion application_changeset: 8ad5338081026c48029d72f1e6c1668a58489bec 06:39:22 INFO - mozversion application_display_name: Nightly 06:39:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:39:22 INFO - mozversion application_name: Firefox 06:39:22 INFO - mozversion application_remotingname: firefox 06:39:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:39:22 INFO - mozversion application_vendor: Mozilla 06:39:22 INFO - mozversion application_version: 55.0a1 06:39:22 INFO - mozversion platform_buildid: 20170510130637 06:39:22 INFO - mozversion platform_changeset: 8ad5338081026c48029d72f1e6c1668a58489bec 06:39:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:39:22 INFO - mozversion platform_version: 55.0a1 06:39:22 INFO - using testdate: 1494423562 06:39:22 INFO - actual date: 1494423562 06:39:22 INFO - starting webserver on 'localhost:53073' 06:39:22 INFO - SUITE-START | Running 2 tests 06:39:22 INFO - TEST-START | dromaeo_css 06:39:22 INFO - operating with platform_type : linux_ 06:39:22 INFO - Initialising browser for dromaeo_css test... 06:39:22 INFO - TEST-INFO | started process 3547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp98ryMg/profile http://localhost:53073/getInfo.html) 06:39:26 INFO - PID 3547 | __metrics Screen width/height:1600/1200 06:39:26 INFO - PID 3547 | colorDepth:24 06:39:26 INFO - PID 3547 | Browser inner width/height: 1024/695 06:39:26 INFO - PID 3547 | __metrics 06:39:28 INFO - TEST-INFO | 3547: exit 0 06:39:28 INFO - Browser initialized. 06:39:28 INFO - Running cycle 1/1 for dromaeo_css test... 06:39:28 INFO - TEST-INFO | started process 3716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp98ryMg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:39:40 INFO - PID 3716 | RSS: Main: 155537408 06:39:40 INFO - PID 3716 | 06:42:47 INFO - PID 3716 | Cycle 1(1): loaded http://localhost:53073/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53073/tests/dromaeo/cssquery-ext.html) 06:42:49 INFO - PID 3716 | RSS: Main: 165269504 06:42:49 INFO - PID 3716 | 06:45:51 INFO - PID 3716 | Cycle 1(1): loaded http://localhost:53073/tests/dromaeo/cssquery-ext.html (next: http://localhost:53073/tests/dromaeo/cssquery-jquery.html) 06:45:52 INFO - PID 3716 | RSS: Main: 160821248 06:45:52 INFO - PID 3716 | 06:48:54 INFO - PID 3716 | Cycle 1(1): loaded http://localhost:53073/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53073/tests/dromaeo/cssquery-mootools.html) 06:48:54 INFO - PID 3716 | RSS: Main: 168992768 06:48:54 INFO - PID 3716 | 06:51:56 INFO - PID 3716 | Cycle 1(1): loaded http://localhost:53073/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53073/tests/dromaeo/cssquery-prototype.html) 06:51:57 INFO - PID 3716 | RSS: Main: 161120256 06:51:57 INFO - PID 3716 | 06:55:00 INFO - PID 3716 | Cycle 1(1): loaded http://localhost:53073/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53073/tests/dromaeo/cssquery-yui.html) 06:55:00 INFO - PID 3716 | RSS: Main: 164958208 06:55:00 INFO - PID 3716 | 06:58:02 INFO - PID 3716 | Cycle 1(1): loaded http://localhost:53073/tests/dromaeo/cssquery-yui.html (next: http://localhost:53073/tests/dromaeo/cssquery-dojo.html) 06:58:02 INFO - PID 3716 | RSS: Main: 168218624 06:58:02 INFO - PID 3716 | 06:58:02 INFO - PID 3716 | __start_tp_report 06:58:02 INFO - PID 3716 | _x_x_mozilla_page_load 06:58:02 INFO - PID 3716 | _x_x_mozilla_page_load_details 06:58:02 INFO - PID 3716 | |i|pagename|runs| 06:58:02 INFO - PID 3716 | |0;dojo.html;2728.1269993602054;2730.9590356144654;2744.656917885264;2762.6961034286223;2763.861806909655;5234.450382709813;5287.28621636079;5321.4412486688925;5327.254184414181;5352.598555108368;5300.469953004697;5347.491988261118;5369.4362091980365;5401.4868587484225;5435.728213589315;4472.127935052666;4714.104320179172;4780.880477988052;4817.831375901844;4852.223644216926;4818.68678535894;4839.4434640016325;4868.148074087038;4885.389326334208;4889.804407823683;4694.554017368345;4718.929216061728;4777.952220477786;4798.1123492154065;4825.565699087099;4738.8341408050555;4768.523147685239;4771.594414474774;4788.664793464459;4816.530958057791;4702.106599746037;4730.976345118287;4731.053789242131;4736.029114031615;4756.07256584966;5229.843104706865;5280.709560974145;5309.973450132725;5329.25390445338;5352.090144675414;5649.802256920988;5660.575456840754;5736.2542869427125;5833.329167145747;5847.415258474161;5872.765089396419;5892.793752218652;5892.852678683024;5902.2032025676845;5914.378990206053;5409.810656626999;5424.783008679608;5427.43011983744;5433.402325744165;5457.426970168154;5885.882282354329;5971.193888824953;5997.520198384119;6007.579469437185;6010.789622363196;5572.804951826748;5600.35595906476;5605.775768969277;5629.521490673257;5630;5693.430656934273;5717.171010203498;5720.77116915327;5744.885102298014;5764.308283006066;5607.074832652648;5661.66030038199;5665.178549110438;5677.829665110054;5683.346415162227;5640.0693885508435;5653.180288858092;5653.802116925888;5658.943410565842;5660.405657405995;4681.976590117028;4684.391029166255;4692.648051396159;4693.225617773098;4712.269598212282;3654.4518322251874;4050.5341885683524;4067.8576249831112;4072.1244932339096;4084.9591504085174;5003.324551185543;5014.2979982802435;5015.724135172528;5015.899682006412;5054.69671819692;5883.823485295448;5893.6463812171405;5902.114682797529;5907.7046147692445;5908.350081491032;4878.463369029404;4960.975195124073;4968.975155124202;4988.276699878497;5027.773750181251;4996.150654388763;5119.206522988943;5128.230765385222;5137.51193636604;5155.767990440364;5343.732813359239;5353.464653534771;5365.356157261153;5367.1680889462195;5372.865678358073;5705.857353566194;5775.48020678141;5778.248827652378;5815.79644712433;5854.648721076749;5350.3312085989255;5363.222332761649;5368.060589396762;5384.9730751346;5403.567714582902;5605.243292155506;5713.371529131875;5723.685197314021;5727.226824378822;5727.398623144676;5651.632643878134;5736.856578585569;5745.425457454221;5820.476157145878;5841.532677385714;5578.414266502121;5598.86002849932;5685.232493613309;5694.914576281442;5695.117256825033;5616.1014237721765;5632.127020311858;5634.915476267941;5646.153077038477;5661.0659241226385;5502.284702988586;5521.116621340566;5534.363548192009;5543.61194716366;5544.306961629796;5526.115821468707;5620.072688006433;5647.491725744702;5652.745626446902;5679.432056794452;5487.6981766003255;5498.422665620053;5503.174523821299;5512.862178445571;5528 06:58:02 INFO - PID 3716 | |1;ext.html;611.1321922869524;668.6890595872919;676.4419354032921;1171.4494187731764;1172.6013155527119;31611.68388316116;31909.04272871815;32066.991626046743;32100.839495802546;32132;30634.54048189279;30802.845985770095;30905.536416953764;31046.2238444039;31052.534211986836;6376.7246550689815;6746.730130794763;6887.862242755142;6912.688928998207;6922;6819.522633415663;6885.827854303632;6949.930500695004;6961.23426423093;6974.047266765288;6946.305369463039;6975.0583671204495;6988.301169882997;6992.1259842519685;7017.89473157903;6944.270851560589;6944.687489063004;6957.965210173917;6965.4079403251035;6981.89527157093;6813.080234168373;6908.654567271667;6908.827279318007;6919.308069193091;6919.619420931846;30113.548296775567;30268;30371.544426833614;30556;30570.388592228253;2989.4768415527196;3044.4824379855477;3062.617172853393;3067.89262375818;3089.397567474321;23877.522449551085;23884.164054258017;23971.52056958851;24038.63942040871;24075.638865417033;3109.0983614751694;3127.218195451137;3127.796693214934;3159.41550813098;3166.4617015107488;135939.2030398476;136935.31532342374;136977;147243;150939.24530377387;37634;37817.81091094527;37869;37965;37965.240695185945;39651.603483965366;39716.602833971294;39790;40678.59321406748;42515.36226956598;12132.575359862363;12274.570390036306;12280.877191228152;12304.507819687113;12324.81512777309;9769.413835169913;9816.705498835046;9825.656102036537;9827.75430614226;9863.210943124534;12223.266604003611;12413.31726755019;12451.750964980649;12467.189632674028;12630.179038362661;5268.947310526923;5269.762860671279;5294.708791016531;5388.461153884658;5411.242426060355;885.2608072259607;913.3834661603524;919.4161707315902;923.5520772425368;947.5830634520789;20110.39668809938;20448.488787780425;21010.894945525175;21558;21603;985.7437066362654;987.3828856964398;992.5087081894509;1017.8422344536609;1022.1107636356418;10921;11187.776244475228;11240.100791936626;11324.377159256155;11423.314601123959;181492;182391;182621;183136.6863313658;184492;38412.61587384091;38664;38722.61277387246;38736.22527549433;38861.80569097193;1166.3759888459633;1213.1447329632588;1227.4108427954632;1228.0666693313146;1229.624964385871;19487.8051219486;19751.506212344233;20080;20517.79482205159;20854.895725521274;27744.861275693493;35848;36236.63763362333;36265.27469450543;36337.2747043978;167456;168155;169985;170110;170655;29236;29530.852345738134;29537.852310738308;29580.704192957794;29663.110106696833;33806.661933380354;34308.173273804096;34540;34817.825910870284;35204.119897002776;26242.60636090422;26943.461130777665;26971.460570788866;27321.180364589094;28772.424551508433;26245.266965534087;26525.734742652327;27242;27263.591046133926;27895.16314510568;29639.25901852471;29644.407111858072;29727.55408668915;29790.702092978794;29981.850090749405;25657.871710641328;25973.22080337593;26081.73918260793;26396.736032640198;26436.8678156608;20345.89827050855;21920.561588768454;22306.330810075724;22311.665325019814;22362.888185558968 06:58:02 INFO - PID 3716 | |2;jquery.html;394.1368403197;398.1519363755201;401.53020965470404;414.0848724319254;416.18427881352545;16991.320347186112;17647.47057588273;17689.29242830287;18601.534961625934;19062.52343691405;19064.42806715801;19202.039898005114;19473.123709433075;19576.314828980987;19599.412017639457;5263.552598029172;5419.430959749219;5453.100238460669;5486.588505862056;5498.340199176105;5386.73066346683;5388.488093631118;5393.2719082923895;5416.674999500023;5423.376311724143;5315.803944112563;5328.866778330534;5385.3268341457315;5385.569154467653;5397.325334333208;5297.284866543006;5353;5367.221752845835;5400.702961337125;5403.108487099644;4778.283257511366;4907.558319751204;4907.950920490821;4916.58209052231;4917.975410122926;21553.66767696376;21902.23342183016;21988.230411935507;22155.667664985038;22483.775162248494;1644.9917750411291;1660.8339166083415;1675.154047206153;1682.9495115146565;1685.022686841629;14353.71292574153;14576.489822856149;14930.47743328989;14995.775063374058;15149.242537873062;2014.6977953306975;2034.806693364128;2071.30611245233;2071.4096482502564;2132.680097985299;85530.57234713848;88104;89127.55436222842;89399.10600893972;92464;10141.797164056825;10488.475576221159;10642.73393165177;10711.303765255234;10853.620123295646;14476.638084047772;14484.85515144856;14500.274986250644;14512.709745805025;14717;7384.446166537531;7623.713865752083;7643.885341719879;7755.961220193863;7795.766127016199;7083.858322833617;7112.431005519546;7325.890111648329;7328.67020984057;7340.11918569775;6812.965935170292;6826.385625293748;6839.247682754893;6867.587944723233;6877.312268773083;1801.2704854533936;1806.9367572135175;1851.0837135617687;1858.4889155482351;1960.4804726747138;826.8470332988417;850.3962186847408;852.8251708399763;857.9442336248123;865.2947847504264;17161.570960726083;17333.913330433268;17991.73012404815;18103.63792724138;18217.089145542668;856.905740368559;857.9828403432022;858.1161403754144;860.9827803443897;885.9601317940708;9123.270138388913;9477.241820654332;9488.762780930394;9911.900880991097;10025.548850301753;350263;359106;359431;359705.0368703912;361033;77069;77414.612926935;77433.22566774373;77611.61194194105;77686;1019.0930072235716;1031.0617338222182;1047.0471870597719;1071.394662015974;1072.0298130192189;14661.706765864836;14732.189729564976;15075.396984120513;15153.090814551162;15550.922245388701;37787.43318850274;38782.6121738779;38841.173823926634;38888.80555597204;40040.59959400369;46243;47287;47342;47497;48310.516894832006;7838.960805195938;7852.685892564234;7944.880826787487;7955.920440795518;8217.383696222687;12012.819807703067;12625.305608191271;12648;12859.742805143658;13215.273159976294;11172.273802202832;11273.098152147644;11309.604163854226;11350.829737554108;11671.474783634587;8820.382573219813;8860;9240.630374785202;9703.805923881342;9805;11382.829257561309;11506.30962142274;11520.88479115198;11610.94194529022;11925.403729813648;7892.210778922292;8063.758087257392;8064.798380040546;8165.469244499089;8242.340612750846;11171;11250.718732031437;11293.209475336647;11375.772484550429;11627.593034244099 06:58:02 INFO - PID 3716 | |3;mootools.html;1252.812078188272;1293.5860524632121;1297.3707751740399;1303.8109474126252;1312.1930013041979;9735.756606084842;10110.342827716193;10172.74568135797;10196.337238079519;10301.536430860611;10164.949175254113;10181.745456363595;10234;10239;10352.585896564147;2265.263789268486;2289.610766169755;2289.8626082435026;2302.82728795341;2306.238941149417;2193.5283913958497;2241.9103235870625;2249.8875056247202;2252.68462415262;2252.977470225293;2184.126349460221;2198.5492973940304;2221.4557433428754;2240.529488807352;2241.2491815241915;2128.648772952461;2146.4848436375314;2193.56128774245;2193.703849980256;2194.594000109969;2090.362439455965;2218.367765186914;2218.456478162844;2226.7884550967633;2234.944126396837;10145.543450544743;10149.289549731522;10244.334118282362;10260;10261.538230779634;5698.1452782083015;5948.672822994734;5951.523878089785;5963.4334738199805;5970.820875373745;3176.444122278592;3330.2506935939464;3414.095264754842;3419.1623052352334;3442.1738782692223;1120.1934607082887;1130.4234840231459;1173.2491205628405;1227.4231111377637;1228.1464382254337;14646.41414343425;14651.413943442356;14780.926095369561;14844.332005059798;14887.47893823711;4726.385569875963;4887.462379138292;4889.071076495455;4906.141425250638;5000.67495612784;10706.678799636024;10711.625093121858;10730.409827459409;10732.087772539266;10743.623973161059;5609.102543593006;5619.8595035123635;5620.409856965041;5626.859328516738;5632.718364081779;5102.464241254689;5105.8723531912;5116.9744151279;5212.374515058142;5256.842294731164;3756.6619004289746;3878.96121038786;3918.2555314490155;3948.526176858795;3996.84012639497;1130.350048721988;1146.1976616368574;1148.7599181595922;1154.578578818742;1164.7321116143335;671.5433505216499;705.4567982653328;711.434409644334;715.6707914359349;724.5906063074347;5192.428832828386;5363.410024897258;5442.863928401822;5480.780768769205;5530.778768849282;558.7569407307834;562.6961440821992;564.582209165223;565.6097292867908;569.7891780041411;3354.781939173946;3411.3688967541084;3727.1613886875234;3774.8490060397276;3814.4469051987307;12569.434375453127;13319.467221311234;13407.798883016763;13421.731565368833;13422.328883555783;12832.165909215872;13197.208167509789;13287.20276783396;13445.932770336085;13511.391987360592;7484.850302994018;7601.961990190124;7705.30652241301;7712.922870771333;7854.921450785419;6144.029895247414;6240.28236752761;6335.049742538656;6344.238691357066;6483.643399612878;11729.941350293195;11802.645920622395;11880.702982425508;11961.521539138685;12032.157748957488;12086.697832554257;12096.818547721967;12240.387980600755;12309.507619695112;12476.126671132934;8201.26188643025;8353.916460835313;8387.657974724016;8501.277391421798;8505.95747021261;9163.49600771964;9171.587278572346;9215.76960575991;9239.214666753132;9275.25797936177;8027.5584842834205;8192.221738934792;8360.372972027244;8480;8485.787855303666;7975.282224599814;8062.677492900453;8084.676612935652;8132.715354962548;8194;7216.386607138452;7359.153697324876;7376.96311518439;7387.556746595222;7390.593517356597;4684.461286951908;5373.35519737634;5408.161734931092;5458.235846981346;5691.601587888808;4973.303737476828;4993.900121997613;5059.19052951526;5194.117000109914;5241.056609810118 06:58:02 INFO - PID 3716 | |4;prototype.html;370.2447008103469;391.3523119237661;396.6331143692085;401.14956292659565;402.8469181710951;5415.431379705134;5625.578081643873;5653.190978886758;5658.264425624669;5675.744591493382;5427.240186373911;5490;5490.392063769707;5493.423190564993;5494.642848214863;4110.6300432961025;4143.212789569987;4151.6886233532605;4155.979220103903;4158.771267580282;4027.7312646516402;4103.917921641565;4129.463169787923;4154.543000269968;4155.272827255233;4085.836566537335;4089.161721847029;4090.9386359204636;4098.528669203035;4098.692598055143;4112.115895082572;4116.526599441057;4117.135401565675;4127.463429754142;4128.876133715993;3602.6937710294656;3605.1708107135505;3610.2418492116426;3619.8914032579064;3845.7309088000893;5413;5418.349798024223;5434.592405569559;5437.864053398657;5445.754941027623;5156.278121063016;5173.275741396207;5193.662411943249;5208.583313334924;5215.817446389358;5785.797497087624;5908.729623131047;5952.226210592638;5952.761889524414;5965.3736357682255;4410.016681150311;4444.466664000308;4449.954260748754;4452.220861349283;4466.280482014416;5965.8806823863715;6034.698265086772;6112.327643959161;6154.84580396862;6264.373562643745;4313.835264478636;4336.588024137702;4338.392625032435;4338.47938247406;4351.412559304516;4413.624841888475;4420.381146639473;4421.579949904753;4429.424174857312;4437.7781110944325;4933.728644924564;4946.159152944008;4974.303597496353;5066.138756411419;5154.664946778447;5813.680247586339;5817.941820581825;5843.737031833578;5852.8536786579825;5863.5309175265875;1602.1028224194488;1624.6425786326988;1632.730599451101;1639.9344026239055;1644.5888527868033;1162.1173698608309;1169.9707507312385;1174.301290732013;1175.4240422193234;1177.8292147638545;5066.164082926276;5080.822171223989;5084.3898732152375;5084.3898732152375;5102.923456148161;5904.940950590525;6110.541709371815;6122.54080943931;6130.417610327012;6151.72317245725;4996.90006199874;5061.493850614909;5097.7706003229205;5105.821296254688;5111.693298402033;3177.539256807796;3245.75656825739;3247.512873069011;3248.4640034394533;3250.609926808751;5469.753861076261;5597.944020559824;5614.438556144353;5640.85897852557;5666.320041595035;6211.192544969125;6217.720202590895;6228.439440450381;6233.376662333731;6243.721041819794;5428.864278392914;5555.444455554412;5575.219469274305;5576.442355764472;5581.916271255935;6060.969695151496;6079.908801367895;6082.239720034996;6093;6105.9694701526205;5736.827895163152;5913.970430147821;5933.554983376178;5943.1679564861815;5947.851303717442;5550.972245138749;5552.361478429871;5560.5829562783765;5563.8887222256135;5593.356763972195;4104.5690202529495;4148.709590328648;4150;4159.459270294963;4159.500859896832;5977.491913187428;6084.787032453843;6105.664188469676;6127.295361033538;6131.570790044654;5900.203472531153;5903.940960590339;5912.142739302863;5917.940820591739;5918.437748413894;5745.839788116603;5886.323072846678;5888.970555147197;5897.734601943009;5902.970485147718;5754.165645981393;5762.4525670061275;5780.913286300793;5815.476607105381;5822.301323841166;5895.29256489224;5908.881822363614;5910.468057874812;5910.911336330045;5957.493613042767;5622.859428514156;5715.39988301239;5732;5735.913961290667;5762.423757624204 06:58:02 INFO - PID 3716 | |5;yui.html;734.3977938090768;747.6112421540796;750.996245018775;767.393758930445;768.5888049893307;11401.885981140185;12048.096392770556;13322.600321990332;13983.930080349597;14066.296685165726;14893.553193404216;14993.325300361483;15362.769558456632;15481.84518154818;15540.766888496653;819.2994989284181;835.8202986357932;836.8786525953733;836.9832603347929;840.3109450250797;903.2548147778109;903.7559858838109;903.7876099116702;904.0733248420356;904.2539904578716;944.1078181118845;949.0177666115571;953.637617705271;954.1460392948308;956.6364781383099;938.0338251600793;938.7277689470045;939.5302348825587;939.9050106625739;940.4686352211013;693.6531734132933;695.6035060015793;696.0081883316304;697.476892330752;699.5907394174415;13820.37808298629;13910.652233694238;14069.577912662637;14283.428662853577;14467.71064578713;15079.849201508065;15346.616334591612;15502.5349239523;16031.679366412724;16199.271032803552;11992.820107698391;12069.879301207051;12153.635390938285;12229.694257643541;12285.38573071343;2929.384829185852;2931.2964888426623;2941.58817765513;2959.5264757638674;2965.8072225305286;74898;75504.24495755027;75553.24446755572;76687;78543.60728196379;12242;12392;12418.689532761753;12431.813522797165;12455.93772031134;21898.671519927215;22316.871378794975;22764.658530122062;22951;23031.769682303297;5884.47039766423;6366.458850997625;6507.609543427409;6551.755166518346;6551.967240163864;3112.37752449511;3153;3162.1462205204925;3168.952465713016;3171.444997125494;3375.8649654014057;3446.4657978013447;3466.578702731868;4004.019015341202;4054.3310353791294;771.117070953766;783.7766236622535;785.2304741353505;791.1455627921831;799.7720649614948;591.630231105559;598.7335635642185;612.2989177391861;620.9379062093755;623.3641685480875;9165.633374665073;9405.670801521914;9426.010268921802;9792.363496372713;10270.383776973256;591.2904514582518;596.6927032578226;599.4215581963426;600.3636145685588;614.7479533391288;4279.7218180818145;4479.260921947907;4535.63714902807;4649.558291962258;4669.066186762661;64280.67859660672;64281.67859160768;64616.353836461974;65361.67319163374;68196.6590167056;56238.156427653616;56284.43715562874;58774.11838822421;58850.411495885346;60290.09564856443;51530;51679.22481162786;52383.47616523862;53932.19101713478;54180.729096355055;9108.635654573744;9211.124943130391;9263.9809620943;9268.397554158959;9436.103570160823;25045.373865653506;25392;25699.35751606225;26181.73818261793;26529.60205596879;43612.34581481217;43921;43936.780316098215;44758.77620611876;44930.1013979712;13471.12437691547;14029.579112626638;14050;14158.150510969375;14184.290785460893;15771.29029193666;15957.122358269942;15982.760258595898;16056.116913569398;16348.182590870647;13126.671833204246;13278.269695166859;13324.200547967153;13340.799888001493;13751.724965500835;14791.778123328373;14861.256937153315;14974.550763477113;15029.924850376116;15214.619634509227;13141.34293285351;13369.799453008018;13439.529616463376;13490.662733431744;13792.793108103186;9503.857442138511;9575.377600455948;9710.514474276399;9715.854262185932;9740.074692904163;10340.793184136124;10407.167426606005;11486.885131148916;11724.179307448398;11740.178187526792 06:58:02 INFO - PID 3716 | __end_tp_report 06:58:02 INFO - PID 3716 | __start_cc_report 06:58:02 INFO - PID 3716 | _x_x_mozilla_cycle_collect,362 06:58:02 INFO - PID 3716 | __end_cc_report 06:58:02 INFO - PID 3716 | __startTimestamp1494424682814__endTimestamp 06:58:02 INFO - PID 3716 | 06:58:02 INFO - PID 3716 | ------- Summary: start ------- 06:58:02 INFO - PID 3716 | Number of tests: 6 06:58:02 INFO - PID 3716 | 06:58:02 INFO - PID 3716 | [#0] dojo.html Cycles:165 Average:5268.90 Median:5433.40 stddev:636.37 (11.7%) stddev-sans-first:606.30 06:58:02 INFO - PID 3716 | Values: 2728.1 2731.0 2744.7 2762.7 2763.9 5234.5 5287.3 5321.4 5327.3 5352.6 5300.5 5347.5 5369.4 5401.5 5435.7 4472.1 4714.1 4780.9 4817.8 4852.2 4818.7 4839.4 4868.1 4885.4 4889.8 4694.6 4718.9 4778.0 4798.1 4825.6 4738.8 4768.5 4771.6 4788.7 4816.5 4702.1 4731.0 4731.1 4736.0 4756.1 5229.8 5280.7 5310.0 5329.3 5352.1 5649.8 5660.6 5736.3 5833.3 5847.4 5872.8 5892.8 5892.9 5902.2 5914.4 5409.8 5424.8 5427.4 5433.4 5457.4 5885.9 5971.2 5997.5 6007.6 6010.8 5572.8 5600.4 5605.8 5629.5 5630.0 5693.4 5717.2 5720.8 5744.9 5764.3 5607.1 5661.7 5665.2 5677.8 5683.3 5640.1 5653.2 5653.8 5658.9 5660.4 4682.0 4684.4 4692.6 4693.2 4712.3 3654.5 4050.5 4067.9 4072.1 4085.0 5003.3 5014.3 5015.7 5015.9 5054.7 5883.8 5893.6 5902.1 5907.7 5908.4 4878.5 4961.0 4969.0 4988.3 5027.8 4996.2 5119.2 5128.2 5137.5 5155.8 5343.7 5353.5 5365.4 5367.2 5372.9 5705.9 5775.5 5778.2 5815.8 5854.6 5350.3 5363.2 5368.1 5385.0 5403.6 5605.2 5713.4 5723.7 5727.2 5727.4 5651.6 5736.9 5745.4 5820.5 5841.5 5578.4 5598.9 5685.2 5694.9 5695.1 5616.1 5632.1 5634.9 5646.2 5661.1 5502.3 5521.1 5534.4 5543.6 5544.3 5526.1 5620.1 5647.5 5652.7 5679.4 5487.7 5498.4 5503.2 5512.9 5528.0 06:58:02 INFO - PID 3716 | 06:58:02 INFO - PID 3716 | [#1] ext.html Cycles:180 Average:30424.76 Median:30563.19 stddev:42720.36 (139.8%) stddev-sans-first:42781.55 06:58:02 INFO - PID 3716 | Values: 611.1 668.7 676.4 1171.4 1172.6 31611.7 31909.0 32067.0 32100.8 32132.0 30634.5 30802.8 30905.5 31046.2 31052.5 6376.7 6746.7 6887.9 6912.7 6922.0 6819.5 6885.8 6949.9 6961.2 6974.0 6946.3 6975.1 6988.3 6992.1 7017.9 6944.3 6944.7 6958.0 6965.4 6981.9 6813.1 6908.7 6908.8 6919.3 6919.6 30113.5 30268.0 30371.5 30556.0 30570.4 2989.5 3044.5 3062.6 3067.9 3089.4 23877.5 23884.2 23971.5 24038.6 24075.6 3109.1 3127.2 3127.8 3159.4 3166.5 135939.2 136935.3 136977.0 147243.0 150939.2 37634.0 37817.8 37869.0 37965.0 37965.2 39651.6 39716.6 39790.0 40678.6 42515.4 12132.6 12274.6 12280.9 12304.5 12324.8 9769.4 9816.7 9825.7 9827.8 9863.2 12223.3 12413.3 12451.8 12467.2 12630.2 5268.9 5269.8 5294.7 5388.5 5411.2 885.3 913.4 919.4 923.6 947.6 20110.4 20448.5 21010.9 21558.0 21603.0 985.7 987.4 992.5 1017.8 1022.1 10921.0 11187.8 11240.1 11324.4 11423.3 181492.0 182391.0 182621.0 183136.7 184492.0 38412.6 38664.0 38722.6 38736.2 38861.8 1166.4 1213.1 1227.4 1228.1 1229.6 19487.8 19751.5 20080.0 20517.8 20854.9 27744.9 35848.0 36236.6 36265.3 36337.3 167456.0 168155.0 169985.0 170110.0 170655.0 29236.0 29530.9 29537.9 29580.7 29663.1 33806.7 34308.2 34540.0 34817.8 35204.1 26242.6 26943.5 26971.5 27321.2 28772.4 26245.3 26525.7 27242.0 27263.6 27895.2 29639.3 29644.4 29727.6 29790.7 29981.9 25657.9 25973.2 26081.7 26396.7 26436.9 20345.9 21920.6 22306.3 22311.7 22362.9 06:58:02 INFO - PID 3716 | 06:58:02 INFO - PID 3716 | [#2] jquery.html Cycles:180 Average:24483.35 Median:396.14 stddev:59709.75 (15072.7%) stddev-sans-first:59849.86 06:58:02 INFO - PID 3716 | Values: 394.1 398.2 401.5 414.1 416.2 16991.3 17647.5 17689.3 18601.5 19062.5 19064.4 19202.0 19473.1 19576.3 19599.4 5263.6 5419.4 5453.1 5486.6 5498.3 5386.7 5388.5 5393.3 5416.7 5423.4 5315.8 5328.9 5385.3 5385.6 5397.3 5297.3 5353.0 5367.2 5400.7 5403.1 4778.3 4907.6 4908.0 4916.6 4918.0 21553.7 21902.2 21988.2 22155.7 22483.8 1645.0 1660.8 1675.2 1682.9 1685.0 14353.7 14576.5 14930.5 14995.8 15149.2 2014.7 2034.8 2071.3 2071.4 2132.7 85530.6 88104.0 89127.6 89399.1 92464.0 10141.8 10488.5 10642.7 10711.3 10853.6 14476.6 14484.9 14500.3 14512.7 14717.0 7384.4 7623.7 7643.9 7756.0 7795.8 7083.9 7112.4 7325.9 7328.7 7340.1 6813.0 6826.4 6839.2 6867.6 6877.3 1801.3 1806.9 1851.1 1858.5 1960.5 826.8 850.4 852.8 857.9 865.3 17161.6 17333.9 17991.7 18103.6 18217.1 856.9 858.0 858.1 861.0 886.0 9123.3 9477.2 9488.8 9911.9 10025.5 350263.0 359106.0 359431.0 359705.0 361033.0 77069.0 77414.6 77433.2 77611.6 77686.0 1019.1 1031.1 1047.0 1071.4 1072.0 14661.7 14732.2 15075.4 15153.1 15550.9 37787.4 38782.6 38841.2 38888.8 40040.6 46243.0 47287.0 47342.0 47497.0 48310.5 7839.0 7852.7 7944.9 7955.9 8217.4 12012.8 12625.3 12648.0 12859.7 13215.3 11172.3 11273.1 11309.6 11350.8 11671.5 8820.4 8860.0 9240.6 9703.8 9805.0 11382.8 11506.3 11520.9 11610.9 11925.4 7892.2 8063.8 8064.8 8165.5 8242.3 11171.0 11250.7 11293.2 11375.8 11627.6 06:58:02 INFO - PID 3716 | 06:58:02 INFO - PID 3716 | [#3] mootools.html Cycles:180 Average:6284.29 Median:3584.67 stddev:4014.08 (112.0%) stddev-sans-first:4007.54 06:58:02 INFO - PID 3716 | Values: 1252.8 1293.6 1297.4 1303.8 1312.2 9735.8 10110.3 10172.7 10196.3 10301.5 10164.9 10181.7 10234.0 10239.0 10352.6 2265.3 2289.6 2289.9 2302.8 2306.2 2193.5 2241.9 2249.9 2252.7 2253.0 2184.1 2198.5 2221.5 2240.5 2241.2 2128.6 2146.5 2193.6 2193.7 2194.6 2090.4 2218.4 2218.5 2226.8 2234.9 10145.5 10149.3 10244.3 10260.0 10261.5 5698.1 5948.7 5951.5 5963.4 5970.8 3176.4 3330.3 3414.1 3419.2 3442.2 1120.2 1130.4 1173.2 1227.4 1228.1 14646.4 14651.4 14780.9 14844.3 14887.5 4726.4 4887.5 4889.1 4906.1 5000.7 10706.7 10711.6 10730.4 10732.1 10743.6 5609.1 5619.9 5620.4 5626.9 5632.7 5102.5 5105.9 5117.0 5212.4 5256.8 3756.7 3879.0 3918.3 3948.5 3996.8 1130.4 1146.2 1148.8 1154.6 1164.7 671.5 705.5 711.4 715.7 724.6 5192.4 5363.4 5442.9 5480.8 5530.8 558.8 562.7 564.6 565.6 569.8 3354.8 3411.4 3727.2 3774.8 3814.4 12569.4 13319.5 13407.8 13421.7 13422.3 12832.2 13197.2 13287.2 13445.9 13511.4 7484.9 7602.0 7705.3 7712.9 7854.9 6144.0 6240.3 6335.0 6344.2 6483.6 11729.9 11802.6 11880.7 11961.5 12032.2 12086.7 12096.8 12240.4 12309.5 12476.1 8201.3 8353.9 8387.7 8501.3 8506.0 9163.5 9171.6 9215.8 9239.2 9275.3 8027.6 8192.2 8360.4 8480.0 8485.8 7975.3 8062.7 8084.7 8132.7 8194.0 7216.4 7359.2 7377.0 7387.6 7390.6 4684.5 5373.4 5408.2 5458.2 5691.6 4973.3 4993.9 5059.2 5194.1 5241.1 06:58:02 INFO - PID 3716 | 06:58:02 INFO - PID 3716 | [#4] prototype.html Cycles:180 Average:4858.71 Median:5436.23 stddev:1402.36 (25.8%) stddev-sans-first:1365.23 06:58:02 INFO - PID 3716 | Values: 370.2 391.4 396.6 401.1 402.8 5415.4 5625.6 5653.2 5658.3 5675.7 5427.2 5490.0 5490.4 5493.4 5494.6 4110.6 4143.2 4151.7 4156.0 4158.8 4027.7 4103.9 4129.5 4154.5 4155.3 4085.8 4089.2 4090.9 4098.5 4098.7 4112.1 4116.5 4117.1 4127.5 4128.9 3602.7 3605.2 3610.2 3619.9 3845.7 5413.0 5418.3 5434.6 5437.9 5445.8 5156.3 5173.3 5193.7 5208.6 5215.8 5785.8 5908.7 5952.2 5952.8 5965.4 4410.0 4444.5 4450.0 4452.2 4466.3 5965.9 6034.7 6112.3 6154.8 6264.4 4313.8 4336.6 4338.4 4338.5 4351.4 4413.6 4420.4 4421.6 4429.4 4437.8 4933.7 4946.2 4974.3 5066.1 5154.7 5813.7 5817.9 5843.7 5852.9 5863.5 1602.1 1624.6 1632.7 1639.9 1644.6 1162.1 1170.0 1174.3 1175.4 1177.8 5066.2 5080.8 5084.4 5084.4 5102.9 5904.9 6110.5 6122.5 6130.4 6151.7 4996.9 5061.5 5097.8 5105.8 5111.7 3177.5 3245.8 3247.5 3248.5 3250.6 5469.8 5597.9 5614.4 5640.9 5666.3 6211.2 6217.7 6228.4 6233.4 6243.7 5428.9 5555.4 5575.2 5576.4 5581.9 6061.0 6079.9 6082.2 6093.0 6106.0 5736.8 5914.0 5933.6 5943.2 5947.9 5551.0 5552.4 5560.6 5563.9 5593.4 4104.6 4148.7 4150.0 4159.5 4159.5 5977.5 6084.8 6105.7 6127.3 6131.6 5900.2 5903.9 5912.1 5917.9 5918.4 5745.8 5886.3 5889.0 5897.7 5903.0 5754.2 5762.5 5780.9 5815.5 5822.3 5895.3 5908.9 5910.5 5910.9 5957.5 5622.9 5715.4 5732.0 5735.9 5762.4 06:58:02 INFO - PID 3716 | 06:58:02 INFO - PID 3716 | [#5] yui.html Cycles:180 Average:15741.32 Median:24619.02 stddev:19154.36 (77.8%) stddev-sans-first:19174.94 06:58:02 INFO - PID 3716 | Values: 734.4 747.6 751.0 767.4 768.6 11401.9 12048.1 13322.6 13983.9 14066.3 14893.6 14993.3 15362.8 15481.8 15540.8 819.3 835.8 836.9 837.0 840.3 903.3 903.8 903.8 904.1 904.3 944.1 949.0 953.6 954.1 956.6 938.0 938.7 939.5 939.9 940.5 693.7 695.6 696.0 697.5 699.6 13820.4 13910.7 14069.6 14283.4 14467.7 15079.8 15346.6 15502.5 16031.7 16199.3 11992.8 12069.9 12153.6 12229.7 12285.4 2929.4 2931.3 2941.6 2959.5 2965.8 74898.0 75504.2 75553.2 76687.0 78543.6 12242.0 12392.0 12418.7 12431.8 12455.9 21898.7 22316.9 22764.7 22951.0 23031.8 5884.5 6366.5 6507.6 6551.8 6552.0 3112.4 3153.0 3162.1 3169.0 3171.4 3375.9 3446.5 3466.6 4004.0 4054.3 771.1 783.8 785.2 791.1 799.8 591.6 598.7 612.3 620.9 623.4 9165.6 9405.7 9426.0 9792.4 10270.4 591.3 596.7 599.4 600.4 614.7 4279.7 4479.3 4535.6 4649.6 4669.1 64280.7 64281.7 64616.4 65361.7 68196.7 56238.2 56284.4 58774.1 58850.4 60290.1 51530.0 51679.2 52383.5 53932.2 54180.7 9108.6 9211.1 9264.0 9268.4 9436.1 25045.4 25392.0 25699.4 26181.7 26529.6 43612.3 43921.0 43936.8 44758.8 44930.1 13471.1 14029.6 14050.0 14158.2 14184.3 15771.3 15957.1 15982.8 16056.1 16348.2 13126.7 13278.3 13324.2 13340.8 13751.7 14791.8 14861.3 14974.6 15029.9 15214.6 13141.3 13369.8 13439.5 13490.7 13792.8 9503.9 9575.4 9710.5 9715.9 9740.1 10340.8 10407.2 11486.9 11724.2 11740.2 06:58:02 INFO - PID 3716 | -------- Summary: end -------- 06:58:02 INFO - PID 3716 | 06:58:03 INFO - TEST-INFO | 3716: exit 0 06:58:03 INFO - TEST-OK | dromaeo_css | took 1120636ms 06:58:03 INFO - TEST-START | kraken 06:58:03 INFO - operating with platform_type : linux_ 06:58:03 INFO - Initialising browser for kraken test... 06:58:03 INFO - TEST-INFO | started process 4138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbZhAOT/profile http://localhost:53073/getInfo.html) 06:58:07 INFO - PID 4138 | __metrics Screen width/height:1600/1200 06:58:07 INFO - PID 4138 | colorDepth:24 06:58:07 INFO - PID 4138 | Browser inner width/height: 1024/695 06:58:07 INFO - PID 4138 | __metrics 06:58:09 INFO - TEST-INFO | 4138: exit 0 06:58:09 INFO - Browser initialized. 06:58:09 INFO - Running cycle 1/1 for kraken test... 06:58:09 INFO - TEST-INFO | started process 4310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbZhAOT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:58:21 INFO - PID 4310 | RSS: Main: 155443200 06:58:21 INFO - PID 4310 | 06:58:23 INFO - PID 4310 | Cycle 1(1): loaded http://localhost:53073/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53073/tests/kraken/driver.html?testName=audio-beat-detection) 06:58:24 INFO - PID 4310 | RSS: Main: 161775616 06:58:24 INFO - PID 4310 | 06:58:27 INFO - PID 4310 | Cycle 1(1): loaded http://localhost:53073/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53073/tests/kraken/driver.html?testName=audio-dft) 06:58:28 INFO - PID 4310 | RSS: Main: 160329728 06:58:28 INFO - PID 4310 | 06:58:30 INFO - PID 4310 | Cycle 1(1): loaded http://localhost:53073/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53073/tests/kraken/driver.html?testName=audio-fft) 06:58:31 INFO - PID 4310 | RSS: Main: 156676096 06:58:31 INFO - PID 4310 | 06:58:33 INFO - PID 4310 | Cycle 1(1): loaded http://localhost:53073/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53073/tests/kraken/driver.html?testName=audio-oscillator) 06:58:34 INFO - PID 4310 | RSS: Main: 157048832 06:58:34 INFO - PID 4310 | 06:58:36 INFO - PID 4310 | Cycle 1(1): loaded http://localhost:53073/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53073/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:58:37 INFO - PID 4310 | RSS: Main: 157364224 06:58:37 INFO - PID 4310 | 06:58:40 INFO - PID 4310 | Cycle 1(1): loaded http://localhost:53073/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53073/tests/kraken/driver.html?testName=imaging-darkroom) 06:58:40 INFO - PID 4310 | RSS: Main: 162934784 06:58:40 INFO - PID 4310 | 06:58:44 INFO - PID 4310 | Cycle 1(1): loaded http://localhost:53073/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53073/tests/kraken/driver.html?testName=imaging-desaturate) 06:58:45 INFO - PID 4310 | RSS: Main: 161075200 06:58:45 INFO - PID 4310 | 06:58:47 INFO - PID 4310 | Cycle 1(1): loaded http://localhost:53073/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53073/tests/kraken/driver.html?testName=json-parse-financial) 06:58:48 INFO - PID 4310 | RSS: Main: 161619968 06:58:48 INFO - PID 4310 | 06:58:50 INFO - PID 4310 | Cycle 1(1): loaded http://localhost:53073/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53073/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:58:50 INFO - PID 4310 | RSS: Main: 162217984 06:58:50 INFO - PID 4310 | 06:58:52 INFO - PID 4310 | Cycle 1(1): loaded http://localhost:53073/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53073/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:58:53 INFO - PID 4310 | RSS: Main: 162361344 06:58:53 INFO - PID 4310 | 06:58:55 INFO - PID 4310 | Cycle 1(1): loaded http://localhost:53073/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53073/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:58:55 INFO - PID 4310 | RSS: Main: 162394112 06:58:55 INFO - PID 4310 | 06:58:58 INFO - PID 4310 | Cycle 1(1): loaded http://localhost:53073/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53073/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:58:59 INFO - PID 4310 | RSS: Main: 162406400 06:58:59 INFO - PID 4310 | 06:59:02 INFO - PID 4310 | Cycle 1(1): loaded http://localhost:53073/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53073/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:59:03 INFO - PID 4310 | RSS: Main: 162656256 06:59:03 INFO - PID 4310 | 06:59:05 INFO - PID 4310 | Cycle 1(1): loaded http://localhost:53073/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53073/tests/kraken/driver.html?testName=ai-astar) 06:59:05 INFO - PID 4310 | RSS: Main: 164814848 06:59:05 INFO - PID 4310 | 06:59:05 INFO - PID 4310 | __start_tp_report 06:59:05 INFO - PID 4310 | _x_x_mozilla_page_load 06:59:05 INFO - PID 4310 | _x_x_mozilla_page_load_details 06:59:05 INFO - PID 4310 | |i|pagename|runs| 06:59:05 INFO - PID 4310 | |0;ai-astar;104;112;114;112;113;111;111;111;112;112 06:59:05 INFO - PID 4310 | |1;audio-beat-detection;151;128;127;162;124;124;122;122;149;127 06:59:05 INFO - PID 4310 | |2;audio-dft;164;163;164;162;166;168;166;170;164;164 06:59:05 INFO - PID 4310 | |3;audio-fft;76;76;77;120;75;74;74;75;100;76 06:59:05 INFO - PID 4310 | |4;audio-oscillator;83;86;102;84;84;83;100;85;83;102 06:59:05 INFO - PID 4310 | |5;imaging-gaussian-blur;114;114;114;114;114;116;114;115;118;114 06:59:05 INFO - PID 4310 | |6;imaging-darkroom;152;150;150;152;150;151;150;151;149;151 06:59:05 INFO - PID 4310 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 06:59:05 INFO - PID 4310 | |8;json-parse-financial;53;54;53;53;54;54;53;54;53;55 06:59:05 INFO - PID 4310 | |9;json-stringify-tinderbox;56;57;56;57;55;55;56;56;56;56 06:59:05 INFO - PID 4310 | |10;stanford-crypto-aes;82;83;82;81;82;85;79;84;81;81 06:59:05 INFO - PID 4310 | |11;stanford-crypto-ccm;132;133;139;129;136;133;131;134;178;137 06:59:05 INFO - PID 4310 | |12;stanford-crypto-pbkdf2;199;195;198;197;204;201;189;185;189;190 06:59:05 INFO - PID 4310 | |13;stanford-crypto-sha256-iterative;74;73;74;74;72;70;70;71;72;73 06:59:05 INFO - PID 4310 | __end_tp_report 06:59:05 INFO - PID 4310 | __start_cc_report 06:59:05 INFO - PID 4310 | _x_x_mozilla_cycle_collect,855 06:59:05 INFO - PID 4310 | __end_cc_report 06:59:05 INFO - PID 4310 | __startTimestamp1494424745306__endTimestamp 06:59:05 INFO - PID 4310 | 06:59:05 INFO - PID 4310 | ------- Summary: start ------- 06:59:05 INFO - PID 4310 | Number of tests: 14 06:59:05 INFO - PID 4310 | 06:59:05 INFO - PID 4310 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:2.70 (2.4%) stddev-sans-first:1.00 06:59:05 INFO - PID 4310 | Values: 104.0 112.0 114.0 112.0 113.0 111.0 111.0 111.0 112.0 112.0 06:59:05 INFO - PID 4310 | 06:59:05 INFO - PID 4310 | [#1] audio-beat-detection Cycles:10 Average:133.60 Median:127.50 stddev:14.60 (11.5%) stddev-sans-first:14.06 06:59:05 INFO - PID 4310 | Values: 151.0 128.0 127.0 162.0 124.0 124.0 122.0 122.0 149.0 127.0 06:59:05 INFO - PID 4310 | 06:59:05 INFO - PID 4310 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:2.42 (1.5%) stddev-sans-first:2.54 06:59:05 INFO - PID 4310 | Values: 164.0 163.0 164.0 162.0 166.0 168.0 166.0 170.0 164.0 164.0 06:59:05 INFO - PID 4310 | 06:59:05 INFO - PID 4310 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.50 stddev:15.37 (20.4%) stddev-sans-first:16.13 06:59:05 INFO - PID 4310 | Values: 76.0 76.0 77.0 120.0 75.0 74.0 74.0 75.0 100.0 76.0 06:59:05 INFO - PID 4310 | 06:59:05 INFO - PID 4310 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:83.50 stddev:8.44 (10.1%) stddev-sans-first:8.65 06:59:05 INFO - PID 4310 | Values: 83.0 86.0 102.0 84.0 84.0 83.0 100.0 85.0 83.0 102.0 06:59:05 INFO - PID 4310 | 06:59:05 INFO - PID 4310 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.00 stddev:1.34 (1.2%) stddev-sans-first:1.39 06:59:05 INFO - PID 4310 | Values: 114.0 114.0 114.0 114.0 114.0 116.0 114.0 115.0 118.0 114.0 06:59:05 INFO - PID 4310 | 06:59:05 INFO - PID 4310 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.97 (0.6%) stddev-sans-first:0.88 06:59:05 INFO - PID 4310 | Values: 152.0 150.0 150.0 152.0 150.0 151.0 150.0 151.0 149.0 151.0 06:59:05 INFO - PID 4310 | 06:59:05 INFO - PID 4310 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:59:05 INFO - PID 4310 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 06:59:05 INFO - PID 4310 | 06:59:05 INFO - PID 4310 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 06:59:05 INFO - PID 4310 | Values: 53.0 54.0 53.0 53.0 54.0 54.0 53.0 54.0 53.0 55.0 06:59:05 INFO - PID 4310 | 06:59:05 INFO - PID 4310 | [#9] json-stringify-tinderbox Cycles:10 Average:56.00 Median:56.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 06:59:05 INFO - PID 4310 | Values: 56.0 57.0 56.0 57.0 55.0 55.0 56.0 56.0 56.0 56.0 06:59:05 INFO - PID 4310 | 06:59:05 INFO - PID 4310 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:1.70 (2.1%) stddev-sans-first:1.80 06:59:05 INFO - PID 4310 | Values: 82.0 83.0 82.0 81.0 82.0 85.0 79.0 84.0 81.0 81.0 06:59:05 INFO - PID 4310 | 06:59:05 INFO - PID 4310 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:135.00 stddev:14.29 (10.6%) stddev-sans-first:14.98 06:59:05 INFO - PID 4310 | Values: 132.0 133.0 139.0 129.0 136.0 133.0 131.0 134.0 178.0 137.0 06:59:05 INFO - PID 4310 | 06:59:05 INFO - PID 4310 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.70 Median:197.50 stddev:6.17 (3.1%) stddev-sans-first:6.34 06:59:05 INFO - PID 4310 | Values: 199.0 195.0 198.0 197.0 204.0 201.0 189.0 185.0 189.0 190.0 06:59:05 INFO - PID 4310 | 06:59:05 INFO - PID 4310 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:73.00 stddev:1.57 (2.1%) stddev-sans-first:1.54 06:59:05 INFO - PID 4310 | Values: 74.0 73.0 74.0 74.0 72.0 70.0 70.0 71.0 72.0 73.0 06:59:05 INFO - PID 4310 | -------- Summary: end -------- 06:59:05 INFO - PID 4310 | 06:59:06 INFO - TEST-INFO | 4310: exit 0 06:59:06 INFO - TEST-OK | kraken | took 62938ms 06:59:06 INFO - SUITE-END | took 1183s 06:59:06 INFO - Completed test suite (00:19:44) 06:59:06 INFO - javascript benchmark 06:59:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6746.2110121888745, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2728.1269993602054, 2730.9590356144654, 2744.656917885264, 2762.6961034286223, 2763.861806909655, 5234.450382709813, 5287.28621636079, 5321.4412486688925, 5327.254184414181, 5352.598555108368, 5300.469953004697, 5347.491988261118, 5369.4362091980365, 5401.4868587484225, 5435.728213589315, 4472.127935052666, 4714.104320179172, 4780.880477988052, 4817.831375901844, 4852.223644216926, 4818.68678535894, 4839.4434640016325, 4868.148074087038, 4885.389326334208, 4889.804407823683, 4694.554017368345, 4718.929216061728, 4777.952220477786, 4798.1123492154065, 4825.565699087099, 4738.8341408050555, 4768.523147685239, 4771.594414474774, 4788.664793464459, 4816.530958057791, 4702.106599746037, 4730.976345118287, 4731.053789242131, 4736.029114031615, 4756.07256584966, 5229.843104706865, 5280.709560974145, 5309.973450132725, 5329.25390445338, 5352.090144675414, 5649.802256920988, 5660.575456840754, 5736.2542869427125, 5833.329167145747, 5847.415258474161, 5872.765089396419, 5892.793752218652, 5892.852678683024, 5902.2032025676845, 5914.378990206053, 5409.810656626999, 5424.783008679608, 5427.43011983744, 5433.402325744165, 5457.426970168154, 5885.882282354329, 5971.193888824953, 5997.520198384119, 6007.579469437185, 6010.789622363196, 5572.804951826748, 5600.35595906476, 5605.775768969277, 5629.521490673257, 5630.0, 5693.430656934273, 5717.171010203498, 5720.77116915327, 5744.885102298014, 5764.308283006066, 5607.074832652648, 5661.66030038199, 5665.178549110438, 5677.829665110054, 5683.346415162227, 5640.0693885508435, 5653.180288858092, 5653.802116925888, 5658.943410565842, 5660.405657405995, 4681.976590117028, 4684.391029166255, 4692.648051396159, 4693.225617773098, 4712.269598212282, 3654.4518322251874, 4050.5341885683524, 4067.8576249831112, 4072.1244932339096, 4084.9591504085174, 5003.324551185543, 5014.2979982802435, 5015.724135172528, 5015.899682006412, 5054.69671819692, 5883.823485295448, 5893.6463812171405, 5902.114682797529, 5907.7046147692445, 5908.350081491032, 4878.463369029404, 4960.975195124073, 4968.975155124202, 4988.276699878497, 5027.773750181251, 4996.150654388763, 5119.206522988943, 5128.230765385222, 5137.51193636604, 5155.767990440364, 5343.732813359239, 5353.464653534771, 5365.356157261153, 5367.1680889462195, 5372.865678358073, 5705.857353566194, 5775.48020678141, 5778.248827652378, 5815.79644712433, 5854.648721076749, 5350.3312085989255, 5363.222332761649, 5368.060589396762, 5384.9730751346, 5403.567714582902, 5605.243292155506, 5713.371529131875, 5723.685197314021, 5727.226824378822, 5727.398623144676, 5651.632643878134, 5736.856578585569, 5745.425457454221, 5820.476157145878, 5841.532677385714, 5578.414266502121, 5598.86002849932, 5685.232493613309, 5694.914576281442, 5695.117256825033, 5616.1014237721765, 5632.127020311858, 5634.915476267941, 5646.153077038477, 5661.0659241226385, 5502.284702988586, 5521.116621340566, 5534.363548192009, 5543.61194716366, 5544.306961629796, 5526.115821468707, 5620.072688006433, 5647.491725744702, 5652.745626446902, 5679.432056794452, 5487.6981766003255, 5498.422665620053, 5503.174523821299, 5512.862178445571, 5528.0], "value": 5221.195149988156, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.1321922869524, 668.6890595872919, 676.4419354032921, 1171.4494187731764, 1172.6013155527119, 31611.68388316116, 31909.04272871815, 32066.991626046743, 32100.839495802546, 32132.0, 30634.54048189279, 30802.845985770095, 30905.536416953764, 31046.2238444039, 31052.534211986836, 6376.7246550689815, 6746.730130794763, 6887.862242755142, 6912.688928998207, 6922.0, 6819.522633415663, 6885.827854303632, 6949.930500695004, 6961.23426423093, 6974.047266765288, 6946.305369463039, 6975.0583671204495, 6988.301169882997, 6992.1259842519685, 7017.89473157903, 6944.270851560589, 6944.687489063004, 6957.965210173917, 6965.4079403251035, 6981.89527157093, 6813.080234168373, 6908.654567271667, 6908.827279318007, 6919.308069193091, 6919.619420931846, 30113.548296775567, 30268.0, 30371.544426833614, 30556.0, 30570.388592228253, 2989.4768415527196, 3044.4824379855477, 3062.617172853393, 3067.89262375818, 3089.397567474321, 23877.522449551085, 23884.164054258017, 23971.52056958851, 24038.63942040871, 24075.638865417033, 3109.0983614751694, 3127.218195451137, 3127.796693214934, 3159.41550813098, 3166.4617015107488, 135939.2030398476, 136935.31532342374, 136977.0, 147243.0, 150939.24530377387, 37634.0, 37817.81091094527, 37869.0, 37965.0, 37965.240695185945, 39651.603483965366, 39716.602833971294, 39790.0, 40678.59321406748, 42515.36226956598, 12132.575359862363, 12274.570390036306, 12280.877191228152, 12304.507819687113, 12324.81512777309, 9769.413835169913, 9816.705498835046, 9825.656102036537, 9827.75430614226, 9863.210943124534, 12223.266604003611, 12413.31726755019, 12451.750964980649, 12467.189632674028, 12630.179038362661, 5268.947310526923, 5269.762860671279, 5294.708791016531, 5388.461153884658, 5411.242426060355, 885.2608072259607, 913.3834661603524, 919.4161707315902, 923.5520772425368, 947.5830634520789, 20110.39668809938, 20448.488787780425, 21010.894945525175, 21558.0, 21603.0, 985.7437066362654, 987.3828856964398, 992.5087081894509, 1017.8422344536609, 1022.1107636356418, 10921.0, 11187.776244475228, 11240.100791936626, 11324.377159256155, 11423.314601123959, 181492.0, 182391.0, 182621.0, 183136.6863313658, 184492.0, 38412.61587384091, 38664.0, 38722.61277387246, 38736.22527549433, 38861.80569097193, 1166.3759888459633, 1213.1447329632588, 1227.4108427954632, 1228.0666693313146, 1229.624964385871, 19487.8051219486, 19751.506212344233, 20080.0, 20517.79482205159, 20854.895725521274, 27744.861275693493, 35848.0, 36236.63763362333, 36265.27469450543, 36337.2747043978, 167456.0, 168155.0, 169985.0, 170110.0, 170655.0, 29236.0, 29530.852345738134, 29537.852310738308, 29580.704192957794, 29663.110106696833, 33806.661933380354, 34308.173273804096, 34540.0, 34817.825910870284, 35204.119897002776, 26242.60636090422, 26943.461130777665, 26971.460570788866, 27321.180364589094, 28772.424551508433, 26245.266965534087, 26525.734742652327, 27242.0, 27263.591046133926, 27895.16314510568, 29639.25901852471, 29644.407111858072, 29727.55408668915, 29790.702092978794, 29981.850090749405, 25657.871710641328, 25973.22080337593, 26081.73918260793, 26396.736032640198, 26436.8678156608, 20345.89827050855, 21920.561588768454, 22306.330810075724, 22311.665325019814, 22362.888185558968], "value": 14354.090455843952, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.1368403197, 398.1519363755201, 401.53020965470404, 414.0848724319254, 416.18427881352545, 16991.320347186112, 17647.47057588273, 17689.29242830287, 18601.534961625934, 19062.52343691405, 19064.42806715801, 19202.039898005114, 19473.123709433075, 19576.314828980987, 19599.412017639457, 5263.552598029172, 5419.430959749219, 5453.100238460669, 5486.588505862056, 5498.340199176105, 5386.73066346683, 5388.488093631118, 5393.2719082923895, 5416.674999500023, 5423.376311724143, 5315.803944112563, 5328.866778330534, 5385.3268341457315, 5385.569154467653, 5397.325334333208, 5297.284866543006, 5353.0, 5367.221752845835, 5400.702961337125, 5403.108487099644, 4778.283257511366, 4907.558319751204, 4907.950920490821, 4916.58209052231, 4917.975410122926, 21553.66767696376, 21902.23342183016, 21988.230411935507, 22155.667664985038, 22483.775162248494, 1644.9917750411291, 1660.8339166083415, 1675.154047206153, 1682.9495115146565, 1685.022686841629, 14353.71292574153, 14576.489822856149, 14930.47743328989, 14995.775063374058, 15149.242537873062, 2014.6977953306975, 2034.806693364128, 2071.30611245233, 2071.4096482502564, 2132.680097985299, 85530.57234713848, 88104.0, 89127.55436222842, 89399.10600893972, 92464.0, 10141.797164056825, 10488.475576221159, 10642.73393165177, 10711.303765255234, 10853.620123295646, 14476.638084047772, 14484.85515144856, 14500.274986250644, 14512.709745805025, 14717.0, 7384.446166537531, 7623.713865752083, 7643.885341719879, 7755.961220193863, 7795.766127016199, 7083.858322833617, 7112.431005519546, 7325.890111648329, 7328.67020984057, 7340.11918569775, 6812.965935170292, 6826.385625293748, 6839.247682754893, 6867.587944723233, 6877.312268773083, 1801.2704854533936, 1806.9367572135175, 1851.0837135617687, 1858.4889155482351, 1960.4804726747138, 826.8470332988417, 850.3962186847408, 852.8251708399763, 857.9442336248123, 865.2947847504264, 17161.570960726083, 17333.913330433268, 17991.73012404815, 18103.63792724138, 18217.089145542668, 856.905740368559, 857.9828403432022, 858.1161403754144, 860.9827803443897, 885.9601317940708, 9123.270138388913, 9477.241820654332, 9488.762780930394, 9911.900880991097, 10025.548850301753, 350263.0, 359106.0, 359431.0, 359705.0368703912, 361033.0, 77069.0, 77414.612926935, 77433.22566774373, 77611.61194194105, 77686.0, 1019.0930072235716, 1031.0617338222182, 1047.0471870597719, 1071.394662015974, 1072.0298130192189, 14661.706765864836, 14732.189729564976, 15075.396984120513, 15153.090814551162, 15550.922245388701, 37787.43318850274, 38782.6121738779, 38841.173823926634, 38888.80555597204, 40040.59959400369, 46243.0, 47287.0, 47342.0, 47497.0, 48310.516894832006, 7838.960805195938, 7852.685892564234, 7944.880826787487, 7955.920440795518, 8217.383696222687, 12012.819807703067, 12625.305608191271, 12648.0, 12859.742805143658, 13215.273159976294, 11172.273802202832, 11273.098152147644, 11309.604163854226, 11350.829737554108, 11671.474783634587, 8820.382573219813, 8860.0, 9240.630374785202, 9703.805923881342, 9805.0, 11382.829257561309, 11506.30962142274, 11520.88479115198, 11610.94194529022, 11925.403729813648, 7892.210778922292, 8063.758087257392, 8064.798380040546, 8165.469244499089, 8242.340612750846, 11171.0, 11250.718732031437, 11293.209475336647, 11375.772484550429, 11627.593034244099], "value": 8718.935868779963, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1252.812078188272, 1293.5860524632121, 1297.3707751740399, 1303.8109474126252, 1312.1930013041979, 9735.756606084842, 10110.342827716193, 10172.74568135797, 10196.337238079519, 10301.536430860611, 10164.949175254113, 10181.745456363595, 10234.0, 10239.0, 10352.585896564147, 2265.263789268486, 2289.610766169755, 2289.8626082435026, 2302.82728795341, 2306.238941149417, 2193.5283913958497, 2241.9103235870625, 2249.8875056247202, 2252.68462415262, 2252.977470225293, 2184.126349460221, 2198.5492973940304, 2221.4557433428754, 2240.529488807352, 2241.2491815241915, 2128.648772952461, 2146.4848436375314, 2193.56128774245, 2193.703849980256, 2194.594000109969, 2090.362439455965, 2218.367765186914, 2218.456478162844, 2226.7884550967633, 2234.944126396837, 10145.543450544743, 10149.289549731522, 10244.334118282362, 10260.0, 10261.538230779634, 5698.1452782083015, 5948.672822994734, 5951.523878089785, 5963.4334738199805, 5970.820875373745, 3176.444122278592, 3330.2506935939464, 3414.095264754842, 3419.1623052352334, 3442.1738782692223, 1120.1934607082887, 1130.4234840231459, 1173.2491205628405, 1227.4231111377637, 1228.1464382254337, 14646.41414343425, 14651.413943442356, 14780.926095369561, 14844.332005059798, 14887.47893823711, 4726.385569875963, 4887.462379138292, 4889.071076495455, 4906.141425250638, 5000.67495612784, 10706.678799636024, 10711.625093121858, 10730.409827459409, 10732.087772539266, 10743.623973161059, 5609.102543593006, 5619.8595035123635, 5620.409856965041, 5626.859328516738, 5632.718364081779, 5102.464241254689, 5105.8723531912, 5116.9744151279, 5212.374515058142, 5256.842294731164, 3756.6619004289746, 3878.96121038786, 3918.2555314490155, 3948.526176858795, 3996.84012639497, 1130.350048721988, 1146.1976616368574, 1148.7599181595922, 1154.578578818742, 1164.7321116143335, 671.5433505216499, 705.4567982653328, 711.434409644334, 715.6707914359349, 724.5906063074347, 5192.428832828386, 5363.410024897258, 5442.863928401822, 5480.780768769205, 5530.778768849282, 558.7569407307834, 562.6961440821992, 564.582209165223, 565.6097292867908, 569.7891780041411, 3354.781939173946, 3411.3688967541084, 3727.1613886875234, 3774.8490060397276, 3814.4469051987307, 12569.434375453127, 13319.467221311234, 13407.798883016763, 13421.731565368833, 13422.328883555783, 12832.165909215872, 13197.208167509789, 13287.20276783396, 13445.932770336085, 13511.391987360592, 7484.850302994018, 7601.961990190124, 7705.30652241301, 7712.922870771333, 7854.921450785419, 6144.029895247414, 6240.28236752761, 6335.049742538656, 6344.238691357066, 6483.643399612878, 11729.941350293195, 11802.645920622395, 11880.702982425508, 11961.521539138685, 12032.157748957488, 12086.697832554257, 12096.818547721967, 12240.387980600755, 12309.507619695112, 12476.126671132934, 8201.26188643025, 8353.916460835313, 8387.657974724016, 8501.277391421798, 8505.95747021261, 9163.49600771964, 9171.587278572346, 9215.76960575991, 9239.214666753132, 9275.25797936177, 8027.5584842834205, 8192.221738934792, 8360.372972027244, 8480.0, 8485.787855303666, 7975.282224599814, 8062.677492900453, 8084.676612935652, 8132.715354962548, 8194.0, 7216.386607138452, 7359.153697324876, 7376.96311518439, 7387.556746595222, 7390.593517356597, 4684.461286951908, 5373.35519737634, 5408.161734931092, 5458.235846981346, 5691.601587888808, 4973.303737476828, 4993.900121997613, 5059.19052951526, 5194.117000109914, 5241.056609810118], "value": 4712.742454653969, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.2447008103469, 391.3523119237661, 396.6331143692085, 401.14956292659565, 402.8469181710951, 5415.431379705134, 5625.578081643873, 5653.190978886758, 5658.264425624669, 5675.744591493382, 5427.240186373911, 5490.0, 5490.392063769707, 5493.423190564993, 5494.642848214863, 4110.6300432961025, 4143.212789569987, 4151.6886233532605, 4155.979220103903, 4158.771267580282, 4027.7312646516402, 4103.917921641565, 4129.463169787923, 4154.543000269968, 4155.272827255233, 4085.836566537335, 4089.161721847029, 4090.9386359204636, 4098.528669203035, 4098.692598055143, 4112.115895082572, 4116.526599441057, 4117.135401565675, 4127.463429754142, 4128.876133715993, 3602.6937710294656, 3605.1708107135505, 3610.2418492116426, 3619.8914032579064, 3845.7309088000893, 5413.0, 5418.349798024223, 5434.592405569559, 5437.864053398657, 5445.754941027623, 5156.278121063016, 5173.275741396207, 5193.662411943249, 5208.583313334924, 5215.817446389358, 5785.797497087624, 5908.729623131047, 5952.226210592638, 5952.761889524414, 5965.3736357682255, 4410.016681150311, 4444.466664000308, 4449.954260748754, 4452.220861349283, 4466.280482014416, 5965.8806823863715, 6034.698265086772, 6112.327643959161, 6154.84580396862, 6264.373562643745, 4313.835264478636, 4336.588024137702, 4338.392625032435, 4338.47938247406, 4351.412559304516, 4413.624841888475, 4420.381146639473, 4421.579949904753, 4429.424174857312, 4437.7781110944325, 4933.728644924564, 4946.159152944008, 4974.303597496353, 5066.138756411419, 5154.664946778447, 5813.680247586339, 5817.941820581825, 5843.737031833578, 5852.8536786579825, 5863.5309175265875, 1602.1028224194488, 1624.6425786326988, 1632.730599451101, 1639.9344026239055, 1644.5888527868033, 1162.1173698608309, 1169.9707507312385, 1174.301290732013, 1175.4240422193234, 1177.8292147638545, 5066.164082926276, 5080.822171223989, 5084.3898732152375, 5084.3898732152375, 5102.923456148161, 5904.940950590525, 6110.541709371815, 6122.54080943931, 6130.417610327012, 6151.72317245725, 4996.90006199874, 5061.493850614909, 5097.7706003229205, 5105.821296254688, 5111.693298402033, 3177.539256807796, 3245.75656825739, 3247.512873069011, 3248.4640034394533, 3250.609926808751, 5469.753861076261, 5597.944020559824, 5614.438556144353, 5640.85897852557, 5666.320041595035, 6211.192544969125, 6217.720202590895, 6228.439440450381, 6233.376662333731, 6243.721041819794, 5428.864278392914, 5555.444455554412, 5575.219469274305, 5576.442355764472, 5581.916271255935, 6060.969695151496, 6079.908801367895, 6082.239720034996, 6093.0, 6105.9694701526205, 5736.827895163152, 5913.970430147821, 5933.554983376178, 5943.1679564861815, 5947.851303717442, 5550.972245138749, 5552.361478429871, 5560.5829562783765, 5563.8887222256135, 5593.356763972195, 4104.5690202529495, 4148.709590328648, 4150.0, 4159.459270294963, 4159.500859896832, 5977.491913187428, 6084.787032453843, 6105.664188469676, 6127.295361033538, 6131.570790044654, 5900.203472531153, 5903.940960590339, 5912.142739302863, 5917.940820591739, 5918.437748413894, 5745.839788116603, 5886.323072846678, 5888.970555147197, 5897.734601943009, 5902.970485147718, 5754.165645981393, 5762.4525670061275, 5780.913286300793, 5815.476607105381, 5822.301323841166, 5895.29256489224, 5908.881822363614, 5910.468057874812, 5910.911336330045, 5957.493613042767, 5622.859428514156, 5715.39988301239, 5732.0, 5735.913961290667, 5762.423757624204], "value": 4442.419929214938, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.3977938090768, 747.6112421540796, 750.996245018775, 767.393758930445, 768.5888049893307, 11401.885981140185, 12048.096392770556, 13322.600321990332, 13983.930080349597, 14066.296685165726, 14893.553193404216, 14993.325300361483, 15362.769558456632, 15481.84518154818, 15540.766888496653, 819.2994989284181, 835.8202986357932, 836.8786525953733, 836.9832603347929, 840.3109450250797, 903.2548147778109, 903.7559858838109, 903.7876099116702, 904.0733248420356, 904.2539904578716, 944.1078181118845, 949.0177666115571, 953.637617705271, 954.1460392948308, 956.6364781383099, 938.0338251600793, 938.7277689470045, 939.5302348825587, 939.9050106625739, 940.4686352211013, 693.6531734132933, 695.6035060015793, 696.0081883316304, 697.476892330752, 699.5907394174415, 13820.37808298629, 13910.652233694238, 14069.577912662637, 14283.428662853577, 14467.71064578713, 15079.849201508065, 15346.616334591612, 15502.5349239523, 16031.679366412724, 16199.271032803552, 11992.820107698391, 12069.879301207051, 12153.635390938285, 12229.694257643541, 12285.38573071343, 2929.384829185852, 2931.2964888426623, 2941.58817765513, 2959.5264757638674, 2965.8072225305286, 74898.0, 75504.24495755027, 75553.24446755572, 76687.0, 78543.60728196379, 12242.0, 12392.0, 12418.689532761753, 12431.813522797165, 12455.93772031134, 21898.671519927215, 22316.871378794975, 22764.658530122062, 22951.0, 23031.769682303297, 5884.47039766423, 6366.458850997625, 6507.609543427409, 6551.755166518346, 6551.967240163864, 3112.37752449511, 3153.0, 3162.1462205204925, 3168.952465713016, 3171.444997125494, 3375.8649654014057, 3446.4657978013447, 3466.578702731868, 4004.019015341202, 4054.3310353791294, 771.117070953766, 783.7766236622535, 785.2304741353505, 791.1455627921831, 799.7720649614948, 591.630231105559, 598.7335635642185, 612.2989177391861, 620.9379062093755, 623.3641685480875, 9165.633374665073, 9405.670801521914, 9426.010268921802, 9792.363496372713, 10270.383776973256, 591.2904514582518, 596.6927032578226, 599.4215581963426, 600.3636145685588, 614.7479533391288, 4279.7218180818145, 4479.260921947907, 4535.63714902807, 4649.558291962258, 4669.066186762661, 64280.67859660672, 64281.67859160768, 64616.353836461974, 65361.67319163374, 68196.6590167056, 56238.156427653616, 56284.43715562874, 58774.11838822421, 58850.411495885346, 60290.09564856443, 51530.0, 51679.22481162786, 52383.47616523862, 53932.19101713478, 54180.729096355055, 9108.635654573744, 9211.124943130391, 9263.9809620943, 9268.397554158959, 9436.103570160823, 25045.373865653506, 25392.0, 25699.35751606225, 26181.73818261793, 26529.60205596879, 43612.34581481217, 43921.0, 43936.780316098215, 44758.77620611876, 44930.1013979712, 13471.12437691547, 14029.579112626638, 14050.0, 14158.150510969375, 14184.290785460893, 15771.29029193666, 15957.122358269942, 15982.760258595898, 16056.116913569398, 16348.182590870647, 13126.671833204246, 13278.269695166859, 13324.200547967153, 13340.799888001493, 13751.724965500835, 14791.778123328373, 14861.256937153315, 14974.550763477113, 15029.924850376116, 15214.619634509227, 13141.34293285351, 13369.799453008018, 13439.529616463376, 13490.662733431744, 13792.793108103186, 9503.857442138511, 9575.377600455948, 9710.514474276399, 9715.854262185932, 9740.074692904163, 10340.793184136124, 10407.167426606005, 11486.885131148916, 11724.179307448398, 11740.178187526792], "value": 6890.126537717372, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 114.0, 112.0, 113.0, 111.0, 111.0, 111.0, 112.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 128.0, 127.0, 162.0, 124.0, 124.0, 122.0, 122.0, 149.0, 127.0], "value": 133.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 162.0, 166.0, 168.0, 166.0, 170.0, 164.0, 164.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 120.0, 75.0, 74.0, 74.0, 75.0, 100.0, 76.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 102.0, 84.0, 84.0, 83.0, 100.0, 85.0, 83.0, 102.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 116.0, 114.0, 115.0, 118.0, 114.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 150.0, 152.0, 150.0, 151.0, 150.0, 151.0, 149.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 53.0, 54.0, 54.0, 53.0, 54.0, 53.0, 55.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 57.0, 55.0, 55.0, 56.0, 56.0, 56.0, 56.0], "value": 56.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 82.0, 81.0, 82.0, 85.0, 79.0, 84.0, 81.0, 81.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 133.0, 139.0, 129.0, 136.0, 133.0, 131.0, 134.0, 178.0, 137.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 195.0, 198.0, 197.0, 204.0, 201.0, 189.0, 185.0, 189.0, 190.0], "value": 194.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 74.0, 72.0, 70.0, 70.0, 71.0, 72.0, 73.0], "value": 72.3, "unit": "score"}]}]} 06:59:07 INFO - Return code: 0 06:59:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:59:07 INFO - # TBPL SUCCESS # 06:59:07 INFO - Running post-action listener: _resource_record_post_action 06:59:07 INFO - [mozharness: 2017-05-10 13:59:07.135271Z] Finished run-tests step (success) 06:59:07 INFO - Running post-run listener: _resource_record_post_run 06:59:07 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 379301888; Read time: 16; Write time: 241608 06:59:07 INFO - TinderboxPrint: CPU usage
13.3% 06:59:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 06:59:07 INFO - TinderboxPrint: I/O write bytes / time
379,301,888 / 241,608 06:59:07 INFO - TinderboxPrint: CPU idle
8,304.8 (86.7%) 06:59:07 INFO - TinderboxPrint: CPU user
1,216.5 (12.7%) 06:59:07 INFO - TinderboxPrint: Swap in / out
0 / 0 06:59:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 121532416; Read time: 0; Write time: 99820 06:59:07 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 256536576; Read time: 0; Write time: 141760 06:59:07 INFO - Running post-run listener: _upload_blobber_files 06:59:07 INFO - Blob upload gear active. 06:59:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:59:07 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 06:59:07 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'] 06:59:07 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 06:59:08 INFO - (blobuploader) - INFO - Open directory for files ... 06:59:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:59:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:59:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:59:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:59:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:59:08 INFO - (blobuploader) - INFO - Done attempting. 06:59:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:59:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:59:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:59:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:59:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:59:09 INFO - (blobuploader) - INFO - Done attempting. 06:59:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:59:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:59:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:59:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:59:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:59:12 INFO - (blobuploader) - INFO - Done attempting. 06:59:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:59:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:59:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:59:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:59:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:59:13 INFO - (blobuploader) - INFO - Done attempting. 06:59:13 INFO - (blobuploader) - INFO - Iteration through files over. 06:59:13 INFO - Return code: 0 06:59:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:59:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:59:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a27b1a26b7ddb90b79e1c539bfd3d32b580dd00553bf554a1a7fa9b8627159c6d28e178ed7af221bf72fc352efcb08138294233301119422757d18b94d65ef77", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7763e3320046e2b3bbc7f677ae959d69fb4081abdb785f997273ee1ba85d6c6e669bb97ea1d9a9505599b81b97fc08b8d42f760d1d9640d5a16f7132ddecb3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d74f2ece518da45f88c3de35a60031114358b8256a64d66b3dd067f33ceaaef039ba22f5a21d1464df1e92831a111c7cf40ca7e673b66317efe199b19e36d1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fdb483aedfec939e84655f524ea1e87977b5731c86fc78d943b9f0bace2b9807ff77f93be9403c6d1ce5a187270de6d8140af62aa7f93ece09e1a9459a58d64c"} 06:59:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:59:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:59:13 INFO - Contents: 06:59:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a27b1a26b7ddb90b79e1c539bfd3d32b580dd00553bf554a1a7fa9b8627159c6d28e178ed7af221bf72fc352efcb08138294233301119422757d18b94d65ef77", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7763e3320046e2b3bbc7f677ae959d69fb4081abdb785f997273ee1ba85d6c6e669bb97ea1d9a9505599b81b97fc08b8d42f760d1d9640d5a16f7132ddecb3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d74f2ece518da45f88c3de35a60031114358b8256a64d66b3dd067f33ceaaef039ba22f5a21d1464df1e92831a111c7cf40ca7e673b66317efe199b19e36d1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fdb483aedfec939e84655f524ea1e87977b5731c86fc78d943b9f0bace2b9807ff77f93be9403c6d1ce5a187270de6d8140af62aa7f93ece09e1a9459a58d64c"} 06:59:13 INFO - Running post-run listener: copy_logs_to_upload_dir 06:59:13 INFO - Copying logs to upload dir... 06:59:13 INFO - mkdir: /builds/slave/test/build/upload/logs 06:59:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.270188 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-10 06:59:13.170950) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 06:59:13.175232) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429 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/a27b1a26b7ddb90b79e1c539bfd3d32b580dd00553bf554a1a7fa9b8627159c6d28e178ed7af221bf72fc352efcb08138294233301119422757d18b94d65ef77", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7763e3320046e2b3bbc7f677ae959d69fb4081abdb785f997273ee1ba85d6c6e669bb97ea1d9a9505599b81b97fc08b8d42f760d1d9640d5a16f7132ddecb3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d74f2ece518da45f88c3de35a60031114358b8256a64d66b3dd067f33ceaaef039ba22f5a21d1464df1e92831a111c7cf40ca7e673b66317efe199b19e36d1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fdb483aedfec939e84655f524ea1e87977b5731c86fc78d943b9f0bace2b9807ff77f93be9403c6d1ce5a187270de6d8140af62aa7f93ece09e1a9459a58d64c"} build_url:https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a27b1a26b7ddb90b79e1c539bfd3d32b580dd00553bf554a1a7fa9b8627159c6d28e178ed7af221bf72fc352efcb08138294233301119422757d18b94d65ef77", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7763e3320046e2b3bbc7f677ae959d69fb4081abdb785f997273ee1ba85d6c6e669bb97ea1d9a9505599b81b97fc08b8d42f760d1d9640d5a16f7132ddecb3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d74f2ece518da45f88c3de35a60031114358b8256a64d66b3dd067f33ceaaef039ba22f5a21d1464df1e92831a111c7cf40ca7e673b66317efe199b19e36d1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fdb483aedfec939e84655f524ea1e87977b5731c86fc78d943b9f0bace2b9807ff77f93be9403c6d1ce5a187270de6d8140af62aa7f93ece09e1a9459a58d64c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 06:59:13.204872) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 06:59:13.205315) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1494423497.719659-681431429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004420 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 06:59:13.291427) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 06:59:13.291735) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 06:59:13.292049) ========= ========= Total master_lag: 0.18 =========