builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1494028650.35 results: success (0) revision: 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 16:57:30.349054) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 16:57:30.349635) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 16:57:30.349914) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 16:57:30.399328) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 16:57:30.399616) ========= 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=41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-05 16:57:30-- 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% 221M=0s 2017-05-05 16:57:30 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.359564 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 16:57:30.773217) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 16:57:30.773518) ========= 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=41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016665 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 16:57:30.823014) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 16:57:30.825376) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 --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 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 --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=41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-05 16:57:30,887 truncating revision to first 12 chars 2017-05-05 16:57:30,887 Setting DEBUG logging. 2017-05-05 16:57:30,887 attempt 1/10 2017-05-05 16:57:30,887 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/37a5b7f6f101?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-05 16:57:31,510 unpacking tar archive at: mozilla-central-37a5b7f6f101/testing/mozharness/ program finished with exit code 0 elapsedTime=0.916829 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 16:57:31.756097) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 16:57:31.756416) ========= script_repo_revision: 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 16:57:31.756771) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 16:57:31.757037) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 16:57:31.772130) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-05 16:57:31.772444) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:57:31 INFO - MultiFileLogger online at 20170505 16:57:31 in /builds/slave/test 16:57:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:57:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:57:31 INFO - {'append_to_log': False, 16:57:31 INFO - 'base_work_dir': '/builds/slave/test', 16:57:31 INFO - 'blob_upload_branch': 'Firefox', 16:57:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:57:31 INFO - 'branch': 'Firefox', 16:57:31 INFO - 'buildbot_json_path': 'buildprops.json', 16:57:31 INFO - 'config_files': ('talos/linux_config.py',), 16:57:31 INFO - 'default_actions': ('clobber', 16:57:31 INFO - 'read-buildbot-config', 16:57:31 INFO - 'download-and-extract', 16:57:31 INFO - 'populate-webroot', 16:57:31 INFO - 'create-virtualenv', 16:57:31 INFO - 'install', 16:57:31 INFO - 'run-tests'), 16:57:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:57:31 INFO - 'download_minidump_stackwalk': True, 16:57:31 INFO - 'download_symbols': 'ondemand', 16:57:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:57:31 INFO - 'tooltool.py': '/tools/tooltool.py', 16:57:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:57:31 INFO - '/tools/misc-python/virtualenv.py')}, 16:57:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:57:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:57:31 INFO - 'gecko_profile': False, 16:57:31 INFO - 'gecko_profile_interval': 0, 16:57:31 INFO - 'installer_path': 'installer.exe', 16:57:31 INFO - 'log_level': 'info', 16:57:31 INFO - 'log_name': 'talos', 16:57:31 INFO - 'log_to_console': True, 16:57:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:57:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:57:31 INFO - 'opt_config_files': (), 16:57:31 INFO - 'pip_index': False, 16:57:31 INFO - 'suite': 'dromaeojs-e10s', 16:57:31 INFO - 'system_bits': '32', 16:57:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:57:31 INFO - 'title': 'talos-linux64-ix-026', 16:57:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:57:31 INFO - 'use_talos_json': True, 16:57:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:57:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:57:31 INFO - 'work_dir': 'build'} 16:57:31 INFO - [mozharness: 2017-05-05 23:57:31.932985Z] Running clobber step. 16:57:31 INFO - Running pre-action listener: _resource_record_pre_action 16:57:31 INFO - Running main action method: clobber 16:57:31 INFO - rmtree: /builds/slave/test/build 16:57:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:57:32 INFO - Running post-action listener: _resource_record_post_action 16:57:32 INFO - [mozharness: 2017-05-05 23:57:32.863010Z] Finished clobber step (success) 16:57:32 INFO - [mozharness: 2017-05-05 23:57:32.863110Z] Running read-buildbot-config step. 16:57:32 INFO - Running pre-action listener: _resource_record_pre_action 16:57:32 INFO - Running main action method: read_buildbot_config 16:57:32 INFO - Using buildbot properties: 16:57:32 INFO - { 16:57:32 INFO - "project": "", 16:57:32 INFO - "product": "firefox", 16:57:32 INFO - "who": "kwierso@gmail.com", 16:57:32 INFO - "installer_path": "public/build/target.tar.bz2", 16:57:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 16:57:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:57:32 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 16:57:32 INFO - "stage_platform": "linux64-stylo", 16:57:32 INFO - "basedir": "/builds/slave/test", 16:57:32 INFO - "buildnumber": 80, 16:57:32 INFO - "platform": "ubuntu64_hw_stylo", 16:57:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:57:32 INFO - "slavebuilddir": "test", 16:57:32 INFO - "taskId": "J7cq7d7YSXOMcVBO-XMIoQ", 16:57:32 INFO - "branch": "mozilla-central", 16:57:32 INFO - "script_repo_revision": "production", 16:57:32 INFO - "revision": "37a5b7f6f101df2eb292b1b6baaf1540c9920e20", 16:57:32 INFO - "slavename": "talos-linux64-ix-026", 16:57:32 INFO - "repo_path": "mozilla-central" 16:57:32 INFO - } 16:57:32 INFO - Finding installer, test and symbols from parent task. 16:57:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J7cq7d7YSXOMcVBO-XMIoQ'}, attempt #1 16:57:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J7cq7d7YSXOMcVBO-XMIoQ'}, attempt #1 16:57:33 INFO - Task dependencies: EWflnxvjTLGDZGMtKkQrVg 16:57:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg'}, attempt #1 16:57:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.tar.bz2 16:57:34 INFO - Set test_url: https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/test_packages.json 16:57:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.crashreporter-symbols.zip 16:57:34 INFO - Running post-action listener: _resource_record_post_action 16:57:34 INFO - [mozharness: 2017-05-05 23:57:34.231419Z] Finished read-buildbot-config step (success) 16:57:34 INFO - [mozharness: 2017-05-05 23:57:34.231636Z] Running download-and-extract step. 16:57:34 INFO - Running pre-action listener: _resource_record_pre_action 16:57:34 INFO - Running main action method: download_and_extract 16:57:34 INFO - mkdir: /builds/slave/test/build/tests 16:57:34 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')]} 16:57:34 INFO - trying https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.test_packages.json 16:57:34 INFO - Downloading https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:57:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:57:34 INFO - Downloaded 986 bytes. 16:57:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:57:34 INFO - Using the following test package requirements: 16:57:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:57:34 INFO - u'common': [u'target.common.tests.zip'], 16:57:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:57:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:57:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:57:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:57:34 INFO - u'mozbase': [u'target.common.tests.zip'], 16:57:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:57:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:57:34 INFO - u'web-platform': [u'target.common.tests.zip', 16:57:34 INFO - u'target.web-platform.tests.zip'], 16:57:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:57:34 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:57:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.common.tests.zip 16:57:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:57:34 INFO - Fetch https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.common.tests.zip into memory 16:57:36 INFO - Content-Length response header: 58451434 16:57:36 INFO - Bytes received: 58451434 16:57:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:57:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.common.tests.zip 16:57:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:57:46 INFO - Fetch https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.common.tests.zip into memory 16:57:47 INFO - Content-Length response header: 58451434 16:57:47 INFO - Bytes received: 58451434 16:57:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.talos.tests.zip 16:57:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:57:58 INFO - Fetch https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.talos.tests.zip into memory 16:57:59 INFO - Content-Length response header: 14408697 16:57:59 INFO - Bytes received: 14408697 16:58:00 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')]} 16:58:00 INFO - trying https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.tar.bz2 16:58:00 INFO - Downloading https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:58:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:58:02 INFO - Downloaded 59951056 bytes. 16:58:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.tar.bz2 16:58:02 INFO - mkdir: /builds/slave/test/properties 16:58:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:58:02 INFO - Writing to file /builds/slave/test/properties/build_url 16:58:02 INFO - Contents: 16:58:02 INFO - build_url:https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.tar.bz2 16:58:02 INFO - Running post-action listener: _resource_record_post_action 16:58:02 INFO - Running post-action listener: set_extra_try_arguments 16:58:02 INFO - [mozharness: 2017-05-05 23:58:02.054514Z] Finished download-and-extract step (success) 16:58:02 INFO - [mozharness: 2017-05-05 23:58:02.054610Z] Running populate-webroot step. 16:58:02 INFO - Running pre-action listener: _resource_record_pre_action 16:58:02 INFO - Running main action method: populate_webroot 16:58:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:58:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:58:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:58:02 INFO - '--tppagecycles', 16:58:02 INFO - '7'], 16:58:02 INFO - 'tests': ['tsvgm']}}, 16:58:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:58:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:58:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:58:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:58:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:58:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:58:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:58:02 INFO - 'talos_options': ['--disable-e10s'], 16:58:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:58:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:58:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:58:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:58:02 INFO - 'talos_options': ['--disable-e10s'], 16:58:02 INFO - 'tests': ['damp', 'tps']}, 16:58:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:58:02 INFO - 'tests': ['damp', 'tps']}, 16:58:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:58:02 INFO - 'tests': ['dromaeo_dom']}, 16:58:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:58:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:58:02 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:58:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:58:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:58:02 INFO - 'tests': ['a11yr', 16:58:02 INFO - 'ts_paint', 16:58:02 INFO - 'tpaint', 16:58:02 INFO - 'sessionrestore', 16:58:02 INFO - 'sessionrestore_no_auto_restore', 16:58:02 INFO - 'tabpaint']}, 16:58:02 INFO - 'other-e10s': {'tests': ['a11yr', 16:58:02 INFO - 'ts_paint', 16:58:02 INFO - 'tpaint', 16:58:02 INFO - 'sessionrestore', 16:58:02 INFO - 'sessionrestore_no_auto_restore', 16:58:02 INFO - 'tabpaint']}, 16:58:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:58:02 INFO - 'ts_paint', 16:58:02 INFO - 'tpaint', 16:58:02 INFO - 'sessionrestore', 16:58:02 INFO - 'sessionrestore_no_auto_restore', 16:58:02 INFO - 'tabpaint']}, 16:58:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:58:02 INFO - 'ts_paint', 16:58:02 INFO - 'tpaint', 16:58:02 INFO - 'sessionrestore', 16:58:02 INFO - 'sessionrestore_no_auto_restore', 16:58:02 INFO - 'tabpaint']}, 16:58:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:58:02 INFO - 'tests': ['a11yr', 16:58:02 INFO - 'ts_paint', 16:58:02 INFO - 'tpaint', 16:58:02 INFO - 'sessionrestore', 16:58:02 INFO - 'sessionrestore_no_auto_restore', 16:58:02 INFO - 'tabpaint']}, 16:58:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:58:02 INFO - 'tests': ['a11yr', 16:58:02 INFO - 'ts_paint', 16:58:02 INFO - 'tpaint', 16:58:02 INFO - 'sessionrestore', 16:58:02 INFO - 'sessionrestore_no_auto_restore', 16:58:02 INFO - 'tabpaint']}, 16:58:02 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:58:02 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:58:02 INFO - 'bloom_basic_ref']}, 16:58:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:58:02 INFO - 'tests': ['tsvgx', 16:58:02 INFO - 'tsvgr_opacity', 16:58:02 INFO - 'tart', 16:58:02 INFO - 'tscrollx', 16:58:02 INFO - 'cart', 16:58:02 INFO - 'tsvg_static']}, 16:58:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:58:02 INFO - 'tsvgr_opacity', 16:58:02 INFO - 'tart', 16:58:02 INFO - 'tscrollx', 16:58:02 INFO - 'cart', 16:58:02 INFO - 'tsvg_static']}, 16:58:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:58:02 INFO - 'talos_options': ['--disable-e10s'], 16:58:02 INFO - 'tests': ['tp5o']}, 16:58:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:58:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:58:02 INFO - 'talos_options': ['--disable-e10s', 16:58:02 INFO - '--xperf_path', 16:58:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:58:02 INFO - 'tests': ['tp5n']}, 16:58:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:58:02 INFO - 'talos_options': ['--xperf_path', 16:58:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:58:02 INFO - 'tests': ['tp5n']}}, 16:58:02 INFO - 'talos.zip': {'path': '', 16:58:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:58:02 INFO - Running post-action listener: _resource_record_post_action 16:58:02 INFO - [mozharness: 2017-05-05 23:58:02.068175Z] Finished populate-webroot step (success) 16:58:02 INFO - [mozharness: 2017-05-05 23:58:02.068263Z] Running create-virtualenv step. 16:58:02 INFO - Running pre-action listener: _resource_record_pre_action 16:58:02 INFO - Running main action method: create_virtualenv 16:58:02 INFO - Creating virtualenv /builds/slave/test/build/venv 16:58:02 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 16:58:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:58:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:58:02 INFO - Using real prefix '/usr' 16:58:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:58:02 INFO - Installing distribute.............................................................................................................................................................................................done. 16:58:04 INFO - Installing pip.................done. 16:58:04 INFO - Return code: 0 16:58:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:58:04 INFO - Reading from file tmpfile_stdout 16:58:04 INFO - Output received: 16:58:04 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) 16:58:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5290>, '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 0x2ca5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca6040>, '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': '41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579', '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 16:58:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:58:04 INFO - Using env: {'DISPLAY': ':0', 16:58:04 INFO - 'HOME': '/home/cltbld', 16:58:04 INFO - 'LANG': 'en_US.UTF-8', 16:58:04 INFO - 'LANGUAGE': 'en_US:en', 16:58:04 INFO - 'LOGNAME': 'cltbld', 16:58:04 INFO - 'MAIL': '/var/mail/cltbld', 16:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:04 INFO - 'MOZ_NO_REMOTE': '1', 16:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:04 INFO - 'NO_EM_RESTART': '1', 16:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:04 INFO - 'PWD': '/builds/slave/test', 16:58:04 INFO - 'SHELL': '/bin/bash', 16:58:04 INFO - 'SHLVL': '1', 16:58:04 INFO - 'TERM': 'linux', 16:58:04 INFO - 'TMOUT': '86400', 16:58:04 INFO - 'USER': 'cltbld', 16:58:04 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579', 16:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:04 INFO - '_': '/tools/buildbot/bin/python'} 16:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:05 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 16:58:05 INFO - Cleaning up... 16:58:05 INFO - Return code: 0 16:58:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2a0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5290>, '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 0x2ca5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca6040>, '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': '41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579', '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 16:58:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:58:05 INFO - Using env: {'DISPLAY': ':0', 16:58:05 INFO - 'HOME': '/home/cltbld', 16:58:05 INFO - 'LANG': 'en_US.UTF-8', 16:58:05 INFO - 'LANGUAGE': 'en_US:en', 16:58:05 INFO - 'LOGNAME': 'cltbld', 16:58:05 INFO - 'MAIL': '/var/mail/cltbld', 16:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:05 INFO - 'MOZ_NO_REMOTE': '1', 16:58:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:05 INFO - 'NO_EM_RESTART': '1', 16:58:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:05 INFO - 'PWD': '/builds/slave/test', 16:58:05 INFO - 'SHELL': '/bin/bash', 16:58:05 INFO - 'SHLVL': '1', 16:58:05 INFO - 'TERM': 'linux', 16:58:05 INFO - 'TMOUT': '86400', 16:58:05 INFO - 'USER': 'cltbld', 16:58:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579', 16:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:05 INFO - '_': '/tools/buildbot/bin/python'} 16:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:05 INFO - Downloading/unpacking psutil>=3.1.1 16:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:58:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:58:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:58:06 INFO - Installing collected packages: psutil 16:58:06 INFO - Running setup.py install for psutil 16:58:06 INFO - building 'psutil._psutil_linux' extension 16:58:06 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 16:58:06 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 16:58:06 INFO - building 'psutil._psutil_posix' extension 16:58:06 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 16:58:06 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 16:58:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:58:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:58:06 INFO - Successfully installed psutil 16:58:06 INFO - Cleaning up... 16:58:06 INFO - Return code: 0 16:58:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:58: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')]} 16:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5290>, '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 0x2ca5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca6040>, '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': '41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579', '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 16:58: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:58: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 mozsystemmonitor==0.3 16:58:06 INFO - Using env: {'DISPLAY': ':0', 16:58:06 INFO - 'HOME': '/home/cltbld', 16:58:06 INFO - 'LANG': 'en_US.UTF-8', 16:58:06 INFO - 'LANGUAGE': 'en_US:en', 16:58:06 INFO - 'LOGNAME': 'cltbld', 16:58:06 INFO - 'MAIL': '/var/mail/cltbld', 16:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:06 INFO - 'MOZ_NO_REMOTE': '1', 16:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:06 INFO - 'NO_EM_RESTART': '1', 16:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:06 INFO - 'PWD': '/builds/slave/test', 16:58:06 INFO - 'SHELL': '/bin/bash', 16:58:06 INFO - 'SHLVL': '1', 16:58:06 INFO - 'TERM': 'linux', 16:58:06 INFO - 'TMOUT': '86400', 16:58:06 INFO - 'USER': 'cltbld', 16:58:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579', 16:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:06 INFO - '_': '/tools/buildbot/bin/python'} 16:58:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:58:07 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 16:58:07 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 16:58:07 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 16:58:07 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 16:58:07 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 16:58:07 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 16:58:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:58:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:58:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:58:08 INFO - Installing collected packages: mozsystemmonitor 16:58:08 INFO - Running setup.py install for mozsystemmonitor 16:58:08 INFO - Successfully installed mozsystemmonitor 16:58:08 INFO - Cleaning up... 16:58:08 INFO - Return code: 0 16:58:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:58:08 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')]} 16:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:08 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')]} 16:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:08 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 0x2a0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5290>, '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 0x2ca5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca6040>, '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': '41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579', '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 16:58:08 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 16:58:08 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 16:58:08 INFO - Using env: {'DISPLAY': ':0', 16:58:08 INFO - 'HOME': '/home/cltbld', 16:58:08 INFO - 'LANG': 'en_US.UTF-8', 16:58:08 INFO - 'LANGUAGE': 'en_US:en', 16:58:08 INFO - 'LOGNAME': 'cltbld', 16:58:08 INFO - 'MAIL': '/var/mail/cltbld', 16:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:08 INFO - 'MOZ_NO_REMOTE': '1', 16:58:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:08 INFO - 'NO_EM_RESTART': '1', 16:58:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:08 INFO - 'PWD': '/builds/slave/test', 16:58:08 INFO - 'SHELL': '/bin/bash', 16:58:08 INFO - 'SHLVL': '1', 16:58:08 INFO - 'TERM': 'linux', 16:58:08 INFO - 'TMOUT': '86400', 16:58:08 INFO - 'USER': 'cltbld', 16:58:08 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579', 16:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:08 INFO - '_': '/tools/buildbot/bin/python'} 16:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:08 INFO - Downloading/unpacking jsonschema==2.5.1 16:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:58:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:58:09 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 16:58:09 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 16:58:09 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 16:58:09 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 16:58:09 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 16:58:09 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 16:58:09 INFO - Downloading functools32-3.2.3-2.tar.gz 16:58:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:58:09 INFO - warning: no files found matching '*.txt' 16:58:09 INFO - no previously-included directories found matching 'build' 16:58:09 INFO - no previously-included directories found matching 'dist' 16:58:09 INFO - no previously-included directories found matching '.git*' 16:58:09 INFO - Installing collected packages: jsonschema, functools32 16:58:09 INFO - Running setup.py install for functools32 16:58:10 INFO - warning: no files found matching '*.txt' 16:58:10 INFO - no previously-included directories found matching 'build' 16:58:10 INFO - no previously-included directories found matching 'dist' 16:58:10 INFO - no previously-included directories found matching '.git*' 16:58:10 INFO - Successfully installed jsonschema functools32 16:58:10 INFO - Cleaning up... 16:58:10 INFO - Return code: 0 16:58:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:10 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 0x2a0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5290>, '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 0x2ca5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca6040>, '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': '41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579', '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 16:58:10 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 16:58:10 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 16:58:10 INFO - Using env: {'DISPLAY': ':0', 16:58:10 INFO - 'HOME': '/home/cltbld', 16:58:10 INFO - 'LANG': 'en_US.UTF-8', 16:58:10 INFO - 'LANGUAGE': 'en_US:en', 16:58:10 INFO - 'LOGNAME': 'cltbld', 16:58:10 INFO - 'MAIL': '/var/mail/cltbld', 16:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:10 INFO - 'MOZ_NO_REMOTE': '1', 16:58:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:10 INFO - 'NO_EM_RESTART': '1', 16:58:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:10 INFO - 'PWD': '/builds/slave/test', 16:58:10 INFO - 'SHELL': '/bin/bash', 16:58:10 INFO - 'SHLVL': '1', 16:58:10 INFO - 'TERM': 'linux', 16:58:10 INFO - 'TMOUT': '86400', 16:58:10 INFO - 'USER': 'cltbld', 16:58:10 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579', 16:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:10 INFO - '_': '/tools/buildbot/bin/python'} 16:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:58:10 INFO - Cleaning up... 16:58:10 INFO - Return code: 0 16:58:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:10 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 0x2a0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5290>, '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 0x2ca5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca6040>, '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': '41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579', '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 16:58:10 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 16:58:10 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 16:58:10 INFO - Using env: {'DISPLAY': ':0', 16:58:10 INFO - 'HOME': '/home/cltbld', 16:58:10 INFO - 'LANG': 'en_US.UTF-8', 16:58:10 INFO - 'LANGUAGE': 'en_US:en', 16:58:10 INFO - 'LOGNAME': 'cltbld', 16:58:10 INFO - 'MAIL': '/var/mail/cltbld', 16:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:10 INFO - 'MOZ_NO_REMOTE': '1', 16:58:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:10 INFO - 'NO_EM_RESTART': '1', 16:58:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:10 INFO - 'PWD': '/builds/slave/test', 16:58:10 INFO - 'SHELL': '/bin/bash', 16:58:10 INFO - 'SHLVL': '1', 16:58:10 INFO - 'TERM': 'linux', 16:58:10 INFO - 'TMOUT': '86400', 16:58:10 INFO - 'USER': 'cltbld', 16:58:10 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579', 16:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:10 INFO - '_': '/tools/buildbot/bin/python'} 16:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:10 INFO - Downloading/unpacking blobuploader==1.2.4 16:58:10 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 16:58:10 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 16:58:10 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 16:58:10 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 16:58:10 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 16:58:10 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 16:58:11 INFO - Downloading blobuploader-1.2.4.tar.gz 16:58:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:58:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:58:11 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 16:58:11 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 16:58:11 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 16:58:11 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 16:58:11 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 16:58:11 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 16:58:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:58:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:12 INFO - Downloading docopt-0.6.1.tar.gz 16:58:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:58:12 INFO - Installing collected packages: blobuploader, requests, docopt 16:58:12 INFO - Running setup.py install for blobuploader 16:58:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:58:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:58:12 INFO - Running setup.py install for requests 16:58:12 INFO - Running setup.py install for docopt 16:58:12 INFO - Successfully installed blobuploader requests docopt 16:58:12 INFO - Cleaning up... 16:58:13 INFO - Return code: 0 16:58:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:13 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 0x2a0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5290>, '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 0x2ca5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca6040>, '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': '41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579', '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 16:58:13 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 16:58:13 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 16:58:13 INFO - Using env: {'DISPLAY': ':0', 16:58:13 INFO - 'HOME': '/home/cltbld', 16:58:13 INFO - 'LANG': 'en_US.UTF-8', 16:58:13 INFO - 'LANGUAGE': 'en_US:en', 16:58:13 INFO - 'LOGNAME': 'cltbld', 16:58:13 INFO - 'MAIL': '/var/mail/cltbld', 16:58:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:13 INFO - 'MOZ_NO_REMOTE': '1', 16:58:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:13 INFO - 'NO_EM_RESTART': '1', 16:58:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:13 INFO - 'PWD': '/builds/slave/test', 16:58:13 INFO - 'SHELL': '/bin/bash', 16:58:13 INFO - 'SHLVL': '1', 16:58:13 INFO - 'TERM': 'linux', 16:58:13 INFO - 'TMOUT': '86400', 16:58:13 INFO - 'USER': 'cltbld', 16:58:13 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579', 16:58:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:13 INFO - '_': '/tools/buildbot/bin/python'} 16:58:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:58:13 INFO - Running setup.py (path:/tmp/pip-a5Pzda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:58:13 INFO - Running setup.py (path:/tmp/pip-gTwQKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:58:13 INFO - Running setup.py (path:/tmp/pip-fOBOaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:58:13 INFO - Running setup.py (path:/tmp/pip-5jrdk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:58:13 INFO - Running setup.py (path:/tmp/pip-u9x1QW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:58:13 INFO - Running setup.py (path:/tmp/pip-ltBS46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:58:13 INFO - Running setup.py (path:/tmp/pip-6C1SR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:58:13 INFO - Running setup.py (path:/tmp/pip-giqA8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:58:13 INFO - Running setup.py (path:/tmp/pip-_dyoqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:58:13 INFO - Running setup.py (path:/tmp/pip-AtKlw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:58:13 INFO - Running setup.py (path:/tmp/pip-6kHPic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:58:14 INFO - Running setup.py (path:/tmp/pip-1BpPWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:58:14 INFO - Running setup.py (path:/tmp/pip-bguYV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:58:14 INFO - Running setup.py (path:/tmp/pip-hWUKlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:14 INFO - Running setup.py (path:/tmp/pip-tcsJAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:58:14 INFO - Running setup.py (path:/tmp/pip-YowUCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:58:14 INFO - Running setup.py (path:/tmp/pip-T8HikZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:58:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:58:14 INFO - Running setup.py install for manifestparser 16:58:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:58:14 INFO - Running setup.py install for mozcrash 16:58:14 INFO - Running setup.py install for mozdebug 16:58:14 INFO - Running setup.py install for mozdevice 16:58:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:58:14 INFO - Running setup.py install for mozfile 16:58:14 INFO - Running setup.py install for mozhttpd 16:58:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:58:15 INFO - Running setup.py install for mozinfo 16:58:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:58:15 INFO - Running setup.py install for mozInstall 16:58:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:58:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:58:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:58:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:58:15 INFO - Running setup.py install for mozleak 16:58:15 INFO - Running setup.py install for mozlog 16:58:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:58:15 INFO - Running setup.py install for moznetwork 16:58:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:58:15 INFO - Running setup.py install for mozprocess 16:58:15 INFO - Running setup.py install for mozprofile 16:58:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:58:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:58:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:58:15 INFO - Running setup.py install for mozrunner 16:58:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:58:15 INFO - Running setup.py install for mozscreenshot 16:58:16 INFO - Running setup.py install for moztest 16:58:16 INFO - Running setup.py install for mozversion 16:58:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:58:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:58:16 INFO - Cleaning up... 16:58:16 INFO - Return code: 0 16:58:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:16 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 0x2a0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5290>, '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 0x2ca5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca6040>, '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': '41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579', '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 16:58:16 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 16:58:16 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 16:58:16 INFO - Using env: {'DISPLAY': ':0', 16:58:16 INFO - 'HOME': '/home/cltbld', 16:58:16 INFO - 'LANG': 'en_US.UTF-8', 16:58:16 INFO - 'LANGUAGE': 'en_US:en', 16:58:16 INFO - 'LOGNAME': 'cltbld', 16:58:16 INFO - 'MAIL': '/var/mail/cltbld', 16:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:16 INFO - 'MOZ_NO_REMOTE': '1', 16:58:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:16 INFO - 'NO_EM_RESTART': '1', 16:58:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:16 INFO - 'PWD': '/builds/slave/test', 16:58:16 INFO - 'SHELL': '/bin/bash', 16:58:16 INFO - 'SHLVL': '1', 16:58:16 INFO - 'TERM': 'linux', 16:58:16 INFO - 'TMOUT': '86400', 16:58:16 INFO - 'USER': 'cltbld', 16:58:16 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579', 16:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:16 INFO - '_': '/tools/buildbot/bin/python'} 16:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:58:16 INFO - Running setup.py (path:/tmp/pip-sHaS8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:58:16 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)) 16:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:58:16 INFO - Running setup.py (path:/tmp/pip-VYNepy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:58:16 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)) 16:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:58:16 INFO - Running setup.py (path:/tmp/pip-Hkuw6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:58:16 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)) 16:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:58:16 INFO - Running setup.py (path:/tmp/pip-VWGZ3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:58:16 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)) 16:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:58:16 INFO - Running setup.py (path:/tmp/pip-G7Uy94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:58:16 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)) 16:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:58:16 INFO - Running setup.py (path:/tmp/pip-MJrn55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:58:16 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)) 16:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:58:16 INFO - Running setup.py (path:/tmp/pip-qfqmso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:58:16 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)) 16:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:58:16 INFO - Running setup.py (path:/tmp/pip-Ya7kbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:58:17 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)) 16:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:58:17 INFO - Running setup.py (path:/tmp/pip-jO94MX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:58:17 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)) 16:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:58:17 INFO - Running setup.py (path:/tmp/pip-jbBZGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:58:17 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)) 16:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:58:17 INFO - Running setup.py (path:/tmp/pip-_XWxG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:58:17 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)) 16:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:58:17 INFO - Running setup.py (path:/tmp/pip-2YiZLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:58:17 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)) 16:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:58:17 INFO - Running setup.py (path:/tmp/pip-lP_3Ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:58:17 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)) 16:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:58:17 INFO - Running setup.py (path:/tmp/pip-vk__sP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:58:17 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)) 16:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:17 INFO - Running setup.py (path:/tmp/pip-xhxNGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:17 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)) 16:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:58:17 INFO - Running setup.py (path:/tmp/pip-dAO37z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:58:17 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)) 16:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:58:17 INFO - Running setup.py (path:/tmp/pip-B5x9Je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:58:17 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)) 16:58:17 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)) 16:58:17 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)) 16:58:17 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)) 16:58:17 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)) 16:58:17 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)) 16:58:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:18 INFO - Downloading blessings-1.6.tar.gz 16:58:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:58:18 INFO - Installing collected packages: blessings 16:58:18 INFO - Running setup.py install for blessings 16:58:18 INFO - Successfully installed blessings 16:58:18 INFO - Cleaning up... 16:58:18 INFO - Return code: 0 16:58:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:58:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:58:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:58:19 INFO - Reading from file tmpfile_stdout 16:58:19 INFO - Current package versions: 16:58:19 INFO - argparse == 1.2.1 16:58:19 INFO - blessings == 1.6 16:58:19 INFO - blobuploader == 1.2.4 16:58:19 INFO - docopt == 0.6.1 16:58:19 INFO - functools32 == 3.2.3-2 16:58:19 INFO - jsonschema == 2.5.1 16:58:19 INFO - manifestparser == 1.1 16:58:19 INFO - mozInstall == 1.12 16:58:19 INFO - mozcrash == 1.0 16:58:19 INFO - mozdebug == 0.1 16:58:19 INFO - mozdevice == 0.50 16:58:19 INFO - mozfile == 1.2 16:58:19 INFO - mozhttpd == 0.7 16:58:19 INFO - mozinfo == 0.9 16:58:19 INFO - mozleak == 0.1 16:58:19 INFO - mozlog == 3.4 16:58:19 INFO - moznetwork == 0.27 16:58:19 INFO - mozprocess == 0.25 16:58:19 INFO - mozprofile == 0.28 16:58:19 INFO - mozrunner == 6.13 16:58:19 INFO - mozscreenshot == 0.1 16:58:19 INFO - mozsystemmonitor == 0.3 16:58:19 INFO - moztest == 0.8 16:58:19 INFO - mozversion == 1.4 16:58:19 INFO - psutil == 3.1.1 16:58:19 INFO - requests == 1.2.3 16:58:19 INFO - wsgiref == 0.1.2 16:58:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58:19 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')]} 16:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:19 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')]} 16:58:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:19 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 0x2a0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5290>, '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 0x2ca5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca6040>, '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': '41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579', '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 16:58:19 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 16:58:19 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 16:58:19 INFO - Using env: {'DISPLAY': ':0', 16:58:19 INFO - 'HOME': '/home/cltbld', 16:58:19 INFO - 'LANG': 'en_US.UTF-8', 16:58:19 INFO - 'LANGUAGE': 'en_US:en', 16:58:19 INFO - 'LOGNAME': 'cltbld', 16:58:19 INFO - 'MAIL': '/var/mail/cltbld', 16:58:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:19 INFO - 'MOZ_NO_REMOTE': '1', 16:58:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:19 INFO - 'NO_EM_RESTART': '1', 16:58:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:19 INFO - 'PWD': '/builds/slave/test', 16:58:19 INFO - 'SHELL': '/bin/bash', 16:58:19 INFO - 'SHLVL': '1', 16:58:19 INFO - 'TERM': 'linux', 16:58:19 INFO - 'TMOUT': '86400', 16:58:19 INFO - 'USER': 'cltbld', 16:58:19 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579', 16:58:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:19 INFO - '_': '/tools/buildbot/bin/python'} 16:58:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:19 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)) 16:58:19 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)) 16:58:19 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)) 16:58:19 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)) 16:58:19 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)) 16:58:19 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)) 16:58:19 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)) 16:58:19 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)) 16:58:19 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)) 16:58:19 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)) 16:58:19 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)) 16:58:19 INFO - Cleaning up... 16:58:19 INFO - Return code: 0 16:58:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:58:19 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')]} 16:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:19 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')]} 16:58:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:19 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 0x2a0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca5290>, '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 0x2ca5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca6040>, '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': '41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579', '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 16:58:19 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 16:58:19 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 16:58:19 INFO - Using env: {'DISPLAY': ':0', 16:58:19 INFO - 'HOME': '/home/cltbld', 16:58:19 INFO - 'LANG': 'en_US.UTF-8', 16:58:19 INFO - 'LANGUAGE': 'en_US:en', 16:58:19 INFO - 'LOGNAME': 'cltbld', 16:58:19 INFO - 'MAIL': '/var/mail/cltbld', 16:58:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:19 INFO - 'MOZ_NO_REMOTE': '1', 16:58:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:19 INFO - 'NO_EM_RESTART': '1', 16:58:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:19 INFO - 'PWD': '/builds/slave/test', 16:58:19 INFO - 'SHELL': '/bin/bash', 16:58:19 INFO - 'SHLVL': '1', 16:58:19 INFO - 'TERM': 'linux', 16:58:19 INFO - 'TMOUT': '86400', 16:58:19 INFO - 'USER': 'cltbld', 16:58:19 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579', 16:58:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:19 INFO - '_': '/tools/buildbot/bin/python'} 16:58:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:58:19 INFO - Cleaning up... 16:58:19 INFO - Return code: 0 16:58:19 INFO - Running post-action listener: _resource_record_post_action 16:58:19 INFO - Running post-action listener: _start_resource_monitoring 16:58:19 INFO - Starting resource monitoring. 16:58:19 INFO - [mozharness: 2017-05-05 23:58:19.695952Z] Finished create-virtualenv step (success) 16:58:19 INFO - [mozharness: 2017-05-05 23:58:19.696473Z] Running install step. 16:58:19 INFO - Running pre-action listener: _resource_record_pre_action 16:58:19 INFO - Running main action method: install 16:58:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:58:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:58:19 INFO - Reading from file tmpfile_stdout 16:58:19 INFO - Detecting whether we're running mozinstall >=1.0... 16:58:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:58:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:58:19 INFO - Reading from file tmpfile_stdout 16:58:19 INFO - Output received: 16:58:19 INFO - Usage: mozinstall [options] installer 16:58:19 INFO - Options: 16:58:19 INFO - -h, --help show this help message and exit 16:58:19 INFO - -d DEST, --destination=DEST 16:58:19 INFO - Directory to install application into. [default: 16:58:19 INFO - "/builds/slave/test"] 16:58:19 INFO - --app=APP Application being installed. [default: firefox] 16:58:19 INFO - mkdir: /builds/slave/test/build/application 16:58:19 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'] 16:58:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:58:35 INFO - Reading from file tmpfile_stdout 16:58:35 INFO - Output received: 16:58:35 INFO - /builds/slave/test/build/application/firefox/firefox 16:58:35 INFO - Running post-action listener: _resource_record_post_action 16:58:35 INFO - [mozharness: 2017-05-05 23:58:35.363372Z] Finished install step (success) 16:58:35 INFO - [mozharness: 2017-05-05 23:58:35.363642Z] Running run-tests step. 16:58:35 INFO - Running pre-action listener: _resource_record_pre_action 16:58:35 INFO - Running main action method: run_tests 16:58:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:58:35 INFO - Python 2.7.3 16:58:35 INFO - Return code: 0 16:58:35 INFO - grabbing minidump binary from tooltool 16:58:35 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')]} 16:58:35 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 0x2ca5290>, '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 0x2ca5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca6040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:58:35 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 16:58:35 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 16:58:35 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 16:58:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:58:35 INFO - Return code: 0 16:58:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:58:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:58:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:58:35 INFO - ENV: RUST_BACKTRACE is now 1 16:58:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:58:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:58:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 16:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 16:58:35 INFO - Using env: {'DISPLAY': ':0', 16:58:35 INFO - 'HOME': '/home/cltbld', 16:58:35 INFO - 'LANG': 'en_US.UTF-8', 16:58:35 INFO - 'LANGUAGE': 'en_US:en', 16:58:35 INFO - 'LOGNAME': 'cltbld', 16:58:35 INFO - 'MAIL': '/var/mail/cltbld', 16:58:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:58:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:35 INFO - 'MOZ_NO_REMOTE': '1', 16:58:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:35 INFO - 'NO_EM_RESTART': '1', 16:58:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:35 INFO - 'PWD': '/builds/slave/test', 16:58:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:58:35 INFO - 'RUST_BACKTRACE': '1', 16:58:35 INFO - 'SHELL': '/bin/bash', 16:58:35 INFO - 'SHLVL': '1', 16:58:35 INFO - 'TERM': 'linux', 16:58:35 INFO - 'TMOUT': '86400', 16:58:35 INFO - 'USER': 'cltbld', 16:58:35 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579', 16:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:35 INFO - '_': '/tools/buildbot/bin/python'} 16:58:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 16:58:35 INFO - mozversion application_buildid: 20170505231114 16:58:35 INFO - mozversion application_changeset: 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 16:58:35 INFO - mozversion application_display_name: Nightly 16:58:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:58:35 INFO - mozversion application_name: Firefox 16:58:35 INFO - mozversion application_remotingname: firefox 16:58:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:58:35 INFO - mozversion application_vendor: Mozilla 16:58:35 INFO - mozversion application_version: 55.0a1 16:58:35 INFO - mozversion platform_buildid: 20170505231114 16:58:35 INFO - mozversion platform_changeset: 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 16:58:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:58:35 INFO - mozversion platform_version: 55.0a1 16:58:35 INFO - using testdate: 1494028715 16:58:35 INFO - actual date: 1494028715 16:58:35 INFO - starting webserver on 'localhost:55687' 16:58:35 INFO - SUITE-START | Running 2 tests 16:58:35 INFO - TEST-START | dromaeo_css 16:58:35 INFO - operating with platform_type : linux_ 16:58:35 INFO - Initialising browser for dromaeo_css test... 16:58:35 INFO - TEST-INFO | started process 8962 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmMUUr2/profile http://localhost:55687/getInfo.html) 16:58:39 INFO - PID 8962 | __metrics Screen width/height:1600/1200 16:58:39 INFO - PID 8962 | colorDepth:24 16:58:39 INFO - PID 8962 | Browser inner width/height: 1024/695 16:58:39 INFO - PID 8962 | __metrics 16:58:41 INFO - TEST-INFO | 8962: exit 0 16:58:41 INFO - Browser initialized. 16:58:41 INFO - Running cycle 1/1 for dromaeo_css test... 16:58:41 INFO - TEST-INFO | started process 9150 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmMUUr2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:58:53 INFO - PID 9150 | RSS: Main: 174387200 16:58:53 INFO - PID 9150 | 17:01:58 INFO - PID 9150 | Cycle 1(1): loaded http://localhost:55687/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55687/tests/dromaeo/cssquery-ext.html) 17:02:00 INFO - PID 9150 | RSS: Main: 182177792 17:02:00 INFO - PID 9150 | 17:05:02 INFO - PID 9150 | Cycle 1(1): loaded http://localhost:55687/tests/dromaeo/cssquery-ext.html (next: http://localhost:55687/tests/dromaeo/cssquery-jquery.html) 17:05:03 INFO - PID 9150 | RSS: Main: 178888704 17:05:03 INFO - PID 9150 | 17:08:04 INFO - PID 9150 | Cycle 1(1): loaded http://localhost:55687/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55687/tests/dromaeo/cssquery-mootools.html) 17:08:05 INFO - PID 9150 | RSS: Main: 188690432 17:08:05 INFO - PID 9150 | 17:11:07 INFO - PID 9150 | Cycle 1(1): loaded http://localhost:55687/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55687/tests/dromaeo/cssquery-prototype.html) 17:11:08 INFO - PID 9150 | RSS: Main: 180084736 17:11:08 INFO - PID 9150 | 17:14:11 INFO - PID 9150 | Cycle 1(1): loaded http://localhost:55687/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55687/tests/dromaeo/cssquery-yui.html) 17:14:11 INFO - PID 9150 | RSS: Main: 186179584 17:14:11 INFO - PID 9150 | 17:17:13 INFO - PID 9150 | Cycle 1(1): loaded http://localhost:55687/tests/dromaeo/cssquery-yui.html (next: http://localhost:55687/tests/dromaeo/cssquery-dojo.html) 17:17:13 INFO - PID 9150 | RSS: Main: 189104128 17:17:13 INFO - PID 9150 | 17:17:13 INFO - PID 9150 | __start_tp_report 17:17:13 INFO - PID 9150 | _x_x_mozilla_page_load 17:17:13 INFO - PID 9150 | _x_x_mozilla_page_load_details 17:17:13 INFO - PID 9150 | |i|pagename|runs| 17:17:13 INFO - PID 9150 | |0;dojo.html;2731.3035176030107;2733.125399872041;2762.2403838944288;2769.5707165389344;2773.1680495851247;5044.82343117991;5077.644564880456;5120.718360490177;5134.897302053957;5136.512031357015;5146.768395422206;5168.61235407345;5190.766415511302;5265.7893684252585;5271.262023316739;4380.92860708936;4600.907981840362;4609.562091601292;4614.700044497114;4632.791524381394;4639.65202609804;4666.580007799297;4688.2264426369775;4720.433547974248;4725.149473094842;4504.527024662396;4539.387182730322;4552.726836389827;4582.03777206787;4632.745199014053;4571.456996468182;4597.885052873671;4601.5168407317415;4617.792199351037;4642.651801114896;4537.591616754475;4538.228501154778;4547.522510136421;4597.126545956257;4645.907081858344;5037.5214354636255;5085.567726743231;5097.23541468779;5101.566366858784;5109.770060347293;5534.695591742453;5591.9720401398135;5661.122526008434;5677.120046392815;5678.977783998878;5606.074997625387;5609.9902017636805;5619.044762390404;5619.775208991636;5624.690642014688;5138.820141295111;5161.458046905096;5162.5095615916425;5162.767675454614;5171.793128274902;5626.409227031185;5688.715564221772;5702.971485142548;5710.8001219957105;5766.711664416763;5375.892482150335;5459.645123066988;5464.590155738336;5465.9180112298345;5467.863303417446;5552.222688823568;5611.046122159243;5623.156526521055;5624.55003599711;5636.520895723827;5548.944510554924;5558.138488534284;5566.526845218121;5569.944300556943;5582.525485333792;5535.418781028015;5552.222688823568;5553.750081246354;5554.805581804618;5562.944370556243;4601.746903920316;4609.377734005866;4620.283856002325;4630.421197350332;4631.166390049823;3552.946705799415;4047.129867078533;4056.127932494528;4092.5907409258834;4102.528209255914;4816.54242846929;4822.493638167942;4822.565969062801;4834.854954351375;4891.755412229374;5625.606207565431;5644.604877658607;5664.546836253172;5666.15007748841;5668.773249069991;4741.288806679026;4765.642576806753;4824.589909857631;4865.5864251538305;4871.342368780241;4832.154372984784;4894.657373983787;4950.851474455772;4975.0547395994645;4976.975115124401;5152.407473140487;5153.768080436314;5199.948000519947;5202.297689811827;5211.635185537052;5522;5546.251256080377;5548.69482178484;5548.889022219452;5575.4424557543925;5138.820141295187;5165.638405311592;5235.581153507634;5279.26090347344;5282.81510147143;5464.26232458613;5507.476789704971;5508.586855985737;5525.419830917695;5572.136318870582;5606.24315717373;5608.831735047955;5612.550995920398;5623.156526521055;5625.943740562542;5303.443138470405;5334.973325133349;5409.675419474844;5488.957098151339;5499.862503437446;5249.763760630857;5484.8354549363585;5491.093969494988;5495.862603434946;5534.557235421237;5368;5417.891642167056;5418.620696551204;5419.268398766116;5475.425080366664;5383.2463455117095;5401.297831281908;5485.040117979258;5526.751296191762;5539.723013849372;5387.407385187705;5390.676559406448;5391.946080539301;5427.891442171055;5459.153831156177 17:17:13 INFO - PID 9150 | |1;ext.html;675.4528831646367;747.3647399710247;757.7461550380622;1081.6160263106597;1083.349990005996;29235.122946311618;30196.3960720786;30246.09261722149;30257.09228723139;30262.84868575654;31383.21541961452;31702.524462133086;31744.68255317446;31776.20559486014;31905.68094319056;6823.147106611674;6839.555428897118;6951.096357473547;6971.442284617244;7001.684924178398;6921.100256966587;6971.477139214579;6996.195437524699;6997.195322537897;7039.542429742076;6985.5110142289805;7037.507374483788;7087.610181440019;7090.113735783028;7100.112485939258;7025.19210290818;7025.543339682904;7051.25961774014;7061.1173603299585;7075.186353569354;6909.343612356868;6976.93023069773;6981.755638552626;6984.720611175598;6987.650617469106;31897.681023189703;32005.839970799996;32036.199095022577;32057.83971080153;32104.6789532104;3005.8046226995175;3051.282948507121;3056.6484854241826;3057.9541306880415;3070.3245286037036;24261.393465163514;24376.268711938672;24453.8428467161;24570.262892113264;24600.384990375205;3039.224997625591;3068.6624471308137;3073.462144124769;3092.4279008383296;3131.9530207046914;137431;137889.3105534476;151262;155530;155876;40154.59845401509;40187;40353.596464035574;40469.59530404658;40507.59492405097;41513.58486415097;41654.58345416507;41739.165216695495;41938.37092443616;41975;12043.458044388024;12090.6700262971;12091.395430228453;12095.75808483843;12124.090693198046;9418.434893906388;9431.575579098957;9445.716628501155;9448.57481413338;9485.430874147436;12742.36288185587;12775.488980440865;12820.935895320463;12846;12857.678558035937;5230.227979171045;5312.495312945264;5319.388270348882;5369.785208591691;5384.784608615611;798.7603718884311;824.8020475085937;857.1557016338901;859.072202021815;860.2214995429147;18869.716954245698;18984.62030759377;19807.60384792296;20072.490938632673;20154.39536813898;906.428949761646;910.4764760262875;924.3160061554402;930.2557953637063;946.2619157057507;10134.341267817568;10277.126444252173;10474.68575942723;10684.412357320267;10730.570777168981;183695;185123;186494;186677.0666146688;186754;40958.18083638311;41430.37854432186;41485;41518.58481415147;41554.37668434976;1222.9266244025387;1267.309316422552;1268.194696367813;1275.2922128218743;1279.4818098670053;18466.35367762122;18876.33932812345;23017;24578.877105614356;24740;38689.2262154761;39073.804630976665;39106.80446597749;39176.804115980376;39376.803115984236;163316;163833;164636;164819;165505;29983.400331993675;30270.84864575663;30870.69129308768;30949.535756964113;31055.223619409695;35634.64365356417;36800;36813.07967300839;36853.26293474062;37010;27434.862825685745;27459;27964.161075166965;28539.143825685263;29022.709772902002;27764.722352776214;27945.580816287365;27971;29171.270718231364;29201.70798292075;29971;30418.695813042472;30975.535366969063;31012.53481197829;31350.843245783624;27267.909283629226;27287.181384558495;27482.725172748018;27867;28783.424331512833;21046;22565.5486890258;22617.66073508866;22878.31365059051;22907.656385153903 17:17:13 INFO - PID 9150 | |2;jquery.html;408.6914379643369;414.9709520333578;418.284733106388;430.6533240741204;433.3845938766951;14785.408583656654;14851.257437128155;15273.694526109484;15401.845981540182;15908.045517268973;17663.205155767988;18013;18235.817641823578;18318.542036449096;18369.265229390843;5333.519983201511;5392.676439413638;5532.114861622142;5548.500634942854;5551.944480555203;5400.378956420022;5485.506304432601;5524.33707955044;5534.916976245359;5542.057850165482;5222.582193424536;5443.891122177574;5461.2354270401975;5493.066178749622;5503.229547863302;5363.8122665706705;5419.024575576375;5424.593155513333;5433.538149257318;5458.153986132156;4894;4904.901901961941;4911.926321105187;4913.385826771653;4915.361003069578;21510.462238444008;21626.35120946374;21655;21673.891630541904;22010.559788804294;1534.7314220011453;1548.0866288889497;1561.0165595674766;1563.335582377485;1564.5150003498952;14297.571072867831;14904.850951490454;14906.776398354034;14968;14970.62573435662;2089.613421517024;2114.6510825713895;2143.6677315016195;2169.9240526581652;2172.196287373666;93019.53490232573;94482.52758736162;94621.67465115526;94821;95494;11143.442827858575;11189.328640281446;11431.485583148778;11445.771084578262;11508.88491115078;15503.84496155024;15566.377344906303;15568.922155389377;15581.298841552158;15615.687686246212;7441.144268409203;7510.6620202091035;7687.500312479671;7693.576853273124;7711.614419279126;6933.2720064393525;6952.617606031717;6980.7905762827195;7111.2533184015965;7153.570785752871;6948.200956889921;6958.965205173941;7086.866101423748;7087.291270872872;7119.857602847914;2070.5755320159633;2075.3773867839586;2080.573482436097;2087.6242276390094;2196.1874106580667;877.5524482513964;903.8101998580372;908.3777612335572;911.5533388639651;928.9907100928904;17038.74441883373;17109.828901711073;17914;17922.820771792376;18138.274469021093;904.1230006893303;910.3721669148438;913.2921985461321;913.7806926337631;927.2442958988403;9641.42151470914;9647.71056868295;9832.705018849447;9887;10091.545880435398;378347;379214;382251;382580;386615;76474;77668.61165694248;78495;78649;81433.59283203546;1083.4853444613746;1090.4384242115316;1100.664297389304;1107.4329823300102;1111.6220485034964;14957.775633365725;15089.320980555682;15354.539363819104;15473.84526154724;15521.223938802788;38089.6191038086;38387.80806095952;38722.41916371313;39090.218195636495;39341.40987885241;46725.53274467212;47267.290990635855;49664.503354965986;49964.25053624271;50680.23979640235;8505.277051450448;8536.573171341532;8587.484750914966;8659.956700216711;8754.410691616407;12809;12820.423080961566;12867.871321287043;12989.805152922525;13454.26001569923;11467.942660286646;11507.597234097102;11617.128715346214;12000.919917207493;12092.45583948742;11212.495437705486;11320.37737924422;11322.830157547478;11432.428378581204;11615.303081815118;10342;10404.11565016982;10869.402182880018;11148.609798657008;11633.243839150766;8086.757397278091;8289.83420331602;8474.61864216124;8507.149285071691;8628.654853805778;11342;11556.191066625255;11763.588274410355;12034.277943323428;12074.75850483003 17:17:13 INFO - PID 9150 | |3;mootools.html;1267.7718010758063;1299.6425982854714;1305.5169587252706;1312.343828085957;1318.1497933832677;8744.825103497926;9040.954795226015;9090.863637045433;9175.678851240207;9187.081291870809;9070.092990700943;9214.677486287981;9305.95347023264;9306.906930930705;9324.11420915012;2060.0935588341117;2095.6437405641;2097.874127552344;2141.9785802141937;2147.055295669908;1998.2107067708246;2039.449348675864;2078.771335153132;2083.8853863037525;2085.8748475091543;1941.9902900485479;1950.112698722078;1959.500327416514;1965.7542807149107;2018.444927644902;2008.6786114221727;2019.0409555461038;2020.5756791073893;2023.4132101690493;2024.2307922989316;1925.8266755991888;1987.2746447546685;2021.1208124465904;2034.8270397016272;2079.7088407622946;9229.98470168281;9397.57710903011;9401.717948461557;9413.529323533865;9447.433154010781;5276.7889284428575;5447.618666693333;5455.699936503491;5469.15228139635;5505.311836020497;3095.1797773590015;3263;3268.215628249227;3299.224682199681;3311.403947289487;1031.6131450705984;1064.3081996702128;1085.2565992295304;1119.5577746789972;1122.9438528073645;13387.732245355135;13615.795763063563;13626.454941802316;13646.2494562799;13696.52062177819;4839.564439200419;4995.350604421402;5083.364579427572;5109.489051094861;5170.069387510209;11476.254043487146;11525.88474115265;11573.479193436315;11585.76828463426;11586.652400428;5522.2544956431175;5538.47384498472;5543.584231182677;5551.168114522198;5564.221009058735;4702.95297047032;4795.808167673254;4865.0756356292895;4908.337374454474;4941.234108713155;4074.7571990542574;4084.0869965812494;4095.3856921461424;4101.979490102531;4142.668586513072;1314.3231235913513;1347.3263368315843;1353.7563238616947;1363.7068030373516;1389.1109689798536;687.2611942162196;707.6072779607265;718.3140101203338;727.149235394579;730.7113690092384;5077.695338279715;5128.897422051613;5203.687778733288;5289.338832645919;5364.597655175878;547.4935684491829;555.5278013688413;557.1141884403818;561.147056474157;568.1591244957486;3144.371125774854;3152.621685397767;3184.8407579620925;3302.7192688621735;3677.485152078711;11732.94133529327;12315.568955086528;12322.876771232173;12370.876291237153;12408.875911240953;12130.393480325949;12270.38648067593;12299;12356.691082723004;12379.75240495185;7259.382952448996;7284.599347035964;7461.552306861606;7461.664225109883;7497.700091996368;5684.7157642118555;5996.340402555803;5999.310079340931;6120.44915957566;6264.060390941395;10513.264071514921;10902.618408355669;10977.725556861142;11024.118070554176;11154.107671386108;10982.450877456255;11075.83386249223;11112.22214444981;11384.772304554028;11509.942450287695;7912.525248485109;7966.16355282687;8055.476394034369;8091.433599647969;8092.109867914407;8744.213020828156;8755.212030917248;8780.341474389574;8806.691765788166;8812.867806982773;7689.269519395649;7817.82732590116;8016.318612917968;8057.113717490954;8098.3116435103675;7492.51298665585;7631.236876312324;7655.808604784925;7658.885116723142;7770.533767973713;6854.657267136524;7043.859122817617;7045.894311585228;7048;7048.977898204629;4989.426215985208;5055.393352797688;5107.846764597068;5115.360579927509;5155.587552995827;5127.692338459704;5160.406553246275;5212.192110222922;5305.31030965972;5316.8936621266585 17:17:13 INFO - PID 9150 | |4;prototype.html;358.81700332830246;368.8303380444995;373.6151763683407;382.1192152089434;387.9243547508236;5321.787128514855;5518.530924871381;5610.158476228567;5629.268195134632;5636;5318.282031925689;5429.728513574325;5464.4262352453015;5468.507834294913;5482.122860342346;4311.159323931826;4312.986448184674;4319.33050377192;4321.157374312011;4324;4244.1511697660435;4292.720973136752;4293.613574778269;4305.935410968838;4337.414449049369;4253.447051883266;4264;4274.294741367687;4275.166342563201;4277.101808620194;4260.275753121977;4268.530461649216;4274.444322238121;4287.442632457761;4294.291441912081;3446.9831399737136;3896.844126234947;3919.9216015679813;3921.4313924481075;3927.528696556403;5214;5230.790768369261;5256.106461901486;5271.894562108736;5311.654742441768;4870.342503761982;4880.438749543812;4886.560209581119;4889.046635906;4895.9755201224125;5585.972070139664;5734.684592347419;5785.2189954356045;5826.708664566755;5834.4165583441745;4049.372347286146;4057.7159598828093;4060.47213862199;4062.593740625943;4066.79666016698;6031.8190454286005;6131.908021379728;6150.3553472007015;6216.720247588869;6233.407826256498;4104.322786740214;4110.321796903538;4116.444280022159;4116.650084742831;4121.093359460914;4174.20690068886;4196.9370459443135;4199.811008504625;4211.642010429086;4218.240716671029;4717.693349932312;4815.470298267188;4838.927416088762;4839.516048395203;4846.473360891308;5828.562857785683;5833.7374818133285;5847.298324201123;5882.705804722954;5883.352831188566;1446.2696338349067;1454.6799704065088;1454.7817827325987;1455.3960106555874;1456.1336005077173;966.3380584299778;968.3366893677712;979.4417182206216;983.2232536296245;985.6008316631776;5088.363954505687;5116.590672746172;5117.360329958755;5154.510321519525;5173.922391164136;5996.820095397145;6002.519798416116;6029.306629737549;6031.4270144336215;6069;4981.252812078217;5012.498750124958;5080.891430056559;5085.949140508547;5133.717645529457;3176.7451856516545;3183.5065564837487;3200.023992682254;3202.5836641236956;3223.403670320998;5354.598405119632;5608.10270356741;5626.38109807929;5628.662280263197;5637.238972738628;6193.225846769154;6228.844278893064;6233.532485063638;6241.313455519889;6300.653464059429;5654.151877218368;5655.830325090254;5656.43435656431;5661.575381846295;5675.5459563234845;5885.970570147122;5947.643141411356;6007.158997740407;6019.398060193946;6059.969700151471;5926.111083337534;5941.257342832146;5943.257092863392;5964.940350596438;5967.671778052075;5434.918476222939;5584.268876648252;5621.353544342453;5633.352164501135;5658.490735833795;4105.938410923898;4144.647704945113;4152.5466086870565;4153.231652144363;4172.102997855475;5932.203389830598;6034.69826508664;6100.786472473442;6105.572609917441;6116;5848.707564621837;5856.502197313106;5879.176915231957;5888.411158884077;5893.204417403767;5863.061910094364;5866.5893387462465;5887.970560147171;5892.528597712087;5898.469137777621;5719.399463056319;5743.712814359349;5791.884162316815;5808.883822323614;5816.127580862735;5885.646861188342;5908.291005079418;5913.994620914369;5919.822405327847;5937.3468918418075;5626.465485778845;5705;5730.879574557441;5742.138679198154;5757.7121143941795 17:17:13 INFO - PID 9150 | |5;yui.html;755.1202848681287;764.2204950950031;775.1086250811562;785.1167436633787;788.6056971514241;12075.396230188499;12302.876971230286;14072.71854562908;14501.347439365241;14570.708585828277;12544.310062946557;15066.54800355991;15539.844601553981;15563.299651515681;15616.84383156168;895.7850115972169;925.2597921662676;925.3568769705058;926.0693003531475;928.2388441477991;925.8935222449403;928.7910220200469;936.5504557812254;938.6620816506087;938.8122375524888;973.6251543155865;979.3389462113081;979.5738853598672;979.6277414582485;980.6763767956558;968.0271327316037;968.8062387522453;970.8058388322329;970.9611615535371;973.7078876337071;711.2176605733652;713.4470785141505;714.1537278325201;716.151360637646;716.9964150179268;14201.360938757678;14270.714585708227;14977.400903963828;15249.39002439901;15299.311530981133;15577.454789082327;15629.452969146025;15872.52382428529;15926.203689815462;16108.919455402647;11398.658040258806;11545.191836571443;11606.303621782636;11676.357800320979;11692.240004399688;2576.059738195564;2606.2181345596246;2612.8562929038894;2621.1350254415997;2625.3174174714522;65373;66184.3381566183;66448;67526.66236668834;68561.65719171372;10937.343759374464;10977.12183025356;11044.834327485094;11162.832557511643;11196.160287978435;17634.470965871045;17911.373101941368;18049;18120.818791811915;18321;6055.061465472859;6283.622982621057;6475.611463312216;6497.090407342976;6518.28298887122;2887.6967918368687;2908.4328555931816;2927.8828846846313;2928.03374886287;2936.0604606526135;3382.5433566468705;3418.0600334907604;3418.7948723076697;3458.913527161841;3462.3594634992605;673.7978606418055;679.1035832700787;681.5944513014748;683.9658017099225;685.4413652872893;571.9370869204384;577.7717801468481;579.1052823387876;582.7465052702004;602.036741214054;8959.41623350665;9537.952310238405;9543.33196676226;9617.71146865595;9931.65239216624;620.9968950155311;638.5434414393638;639.4404895716249;649.4577028181427;658.0589756648039;4246.256905041605;4356.564343565618;4395.846145384896;4416.514183439884;4512.323151527297;60331.69834150889;60645.39354606398;60862.695686521285;62857.37142628515;62925.68537157285;51458;52064.739676301375;52069.218961715604;54828.72585637046;58592.7070364654;45696.13171355469;47028.52971470242;47667.284990725166;50228;50484.74757626262;10369.216015343958;10801.945990269998;10912.181586380895;11034.117270618171;11084.833727493933;26326.86836565805;26599.335016623965;26654.733452665227;27234.182974510797;27689;31151;31525.21186970252;31582;31900.840495797373;32378.35243295168;13467.461301548221;13763.174209547458;13891.097078689852;13960.441582336593;14025.789613155606;13274.867251327363;14889.032212906126;15206.163660998309;16005.599860003593;16438.260278287744;13723.039387242798;13775.517856874962;13923.164610123426;13996.790048149489;14263;13405.798913016508;14185.858141418867;14200.928995354958;14204.644883877985;14275;13694.93152534231;13885.514007009706;13935.442582297;14012.579622611338;14251.714965700836;10094.949525252327;10887.455627218449;11103.16726245551;11349.943250283695;11498.022668073307;11360.886391135982;11753.294802311888;11834.881651183377;11874.287542747463;12065.457054432396 17:17:13 INFO - PID 9150 | __end_tp_report 17:17:13 INFO - PID 9150 | __start_cc_report 17:17:13 INFO - PID 9150 | _x_x_mozilla_cycle_collect,350 17:17:13 INFO - PID 9150 | __end_cc_report 17:17:13 INFO - PID 9150 | __startTimestamp1494029833851__endTimestamp 17:17:13 INFO - PID 9150 | 17:17:13 INFO - PID 9150 | ------- Summary: start ------- 17:17:13 INFO - PID 9150 | Number of tests: 6 17:17:13 INFO - PID 9150 | 17:17:13 INFO - PID 9150 | [#0] dojo.html Cycles:165 Average:5105.66 Median:5265.79 stddev:599.85 (11.4%) stddev-sans-first:572.04 17:17:13 INFO - PID 9150 | Values: 2731.3 2733.1 2762.2 2769.6 2773.2 5044.8 5077.6 5120.7 5134.9 5136.5 5146.8 5168.6 5190.8 5265.8 5271.3 4380.9 4600.9 4609.6 4614.7 4632.8 4639.7 4666.6 4688.2 4720.4 4725.1 4504.5 4539.4 4552.7 4582.0 4632.7 4571.5 4597.9 4601.5 4617.8 4642.7 4537.6 4538.2 4547.5 4597.1 4645.9 5037.5 5085.6 5097.2 5101.6 5109.8 5534.7 5592.0 5661.1 5677.1 5679.0 5606.1 5610.0 5619.0 5619.8 5624.7 5138.8 5161.5 5162.5 5162.8 5171.8 5626.4 5688.7 5703.0 5710.8 5766.7 5375.9 5459.6 5464.6 5465.9 5467.9 5552.2 5611.0 5623.2 5624.6 5636.5 5548.9 5558.1 5566.5 5569.9 5582.5 5535.4 5552.2 5553.8 5554.8 5562.9 4601.7 4609.4 4620.3 4630.4 4631.2 3552.9 4047.1 4056.1 4092.6 4102.5 4816.5 4822.5 4822.6 4834.9 4891.8 5625.6 5644.6 5664.5 5666.2 5668.8 4741.3 4765.6 4824.6 4865.6 4871.3 4832.2 4894.7 4950.9 4975.1 4977.0 5152.4 5153.8 5199.9 5202.3 5211.6 5522.0 5546.3 5548.7 5548.9 5575.4 5138.8 5165.6 5235.6 5279.3 5282.8 5464.3 5507.5 5508.6 5525.4 5572.1 5606.2 5608.8 5612.6 5623.2 5625.9 5303.4 5335.0 5409.7 5489.0 5499.9 5249.8 5484.8 5491.1 5495.9 5534.6 5368.0 5417.9 5418.6 5419.3 5475.4 5383.2 5401.3 5485.0 5526.8 5539.7 5387.4 5390.7 5391.9 5427.9 5459.2 17:17:13 INFO - PID 9150 | 17:17:13 INFO - PID 9150 | [#1] ext.html Cycles:180 Average:31106.35 Median:17020.98 stddev:43090.28 (253.2%) stddev-sans-first:43150.57 17:17:13 INFO - PID 9150 | Values: 675.5 747.4 757.7 1081.6 1083.3 29235.1 30196.4 30246.1 30257.1 30262.8 31383.2 31702.5 31744.7 31776.2 31905.7 6823.1 6839.6 6951.1 6971.4 7001.7 6921.1 6971.5 6996.2 6997.2 7039.5 6985.5 7037.5 7087.6 7090.1 7100.1 7025.2 7025.5 7051.3 7061.1 7075.2 6909.3 6976.9 6981.8 6984.7 6987.7 31897.7 32005.8 32036.2 32057.8 32104.7 3005.8 3051.3 3056.6 3058.0 3070.3 24261.4 24376.3 24453.8 24570.3 24600.4 3039.2 3068.7 3073.5 3092.4 3132.0 137431.0 137889.3 151262.0 155530.0 155876.0 40154.6 40187.0 40353.6 40469.6 40507.6 41513.6 41654.6 41739.2 41938.4 41975.0 12043.5 12090.7 12091.4 12095.8 12124.1 9418.4 9431.6 9445.7 9448.6 9485.4 12742.4 12775.5 12820.9 12846.0 12857.7 5230.2 5312.5 5319.4 5369.8 5384.8 798.8 824.8 857.2 859.1 860.2 18869.7 18984.6 19807.6 20072.5 20154.4 906.4 910.5 924.3 930.3 946.3 10134.3 10277.1 10474.7 10684.4 10730.6 183695.0 185123.0 186494.0 186677.1 186754.0 40958.2 41430.4 41485.0 41518.6 41554.4 1222.9 1267.3 1268.2 1275.3 1279.5 18466.4 18876.3 23017.0 24578.9 24740.0 38689.2 39073.8 39106.8 39176.8 39376.8 163316.0 163833.0 164636.0 164819.0 165505.0 29983.4 30270.8 30870.7 30949.5 31055.2 35634.6 36800.0 36813.1 36853.3 37010.0 27434.9 27459.0 27964.2 28539.1 29022.7 27764.7 27945.6 27971.0 29171.3 29201.7 29971.0 30418.7 30975.5 31012.5 31350.8 27267.9 27287.2 27482.7 27867.0 28783.4 21046.0 22565.5 22617.7 22878.3 22907.7 17:17:13 INFO - PID 9150 | 17:17:13 INFO - PID 9150 | [#2] jquery.html Cycles:180 Average:25422.25 Median:210483.90 stddev:63624.12 (30.2%) stddev-sans-first:63774.88 17:17:13 INFO - PID 9150 | Values: 408.7 415.0 418.3 430.7 433.4 14785.4 14851.3 15273.7 15401.8 15908.0 17663.2 18013.0 18235.8 18318.5 18369.3 5333.5 5392.7 5532.1 5548.5 5551.9 5400.4 5485.5 5524.3 5534.9 5542.1 5222.6 5443.9 5461.2 5493.1 5503.2 5363.8 5419.0 5424.6 5433.5 5458.2 4894.0 4904.9 4911.9 4913.4 4915.4 21510.5 21626.4 21655.0 21673.9 22010.6 1534.7 1548.1 1561.0 1563.3 1564.5 14297.6 14904.9 14906.8 14968.0 14970.6 2089.6 2114.7 2143.7 2169.9 2172.2 93019.5 94482.5 94621.7 94821.0 95494.0 11143.4 11189.3 11431.5 11445.8 11508.9 15503.8 15566.4 15568.9 15581.3 15615.7 7441.1 7510.7 7687.5 7693.6 7711.6 6933.3 6952.6 6980.8 7111.3 7153.6 6948.2 6959.0 7086.9 7087.3 7119.9 2070.6 2075.4 2080.6 2087.6 2196.2 877.6 903.8 908.4 911.6 929.0 17038.7 17109.8 17914.0 17922.8 18138.3 904.1 910.4 913.3 913.8 927.2 9641.4 9647.7 9832.7 9887.0 10091.5 378347.0 379214.0 382251.0 382580.0 386615.0 76474.0 77668.6 78495.0 78649.0 81433.6 1083.5 1090.4 1100.7 1107.4 1111.6 14957.8 15089.3 15354.5 15473.8 15521.2 38089.6 38387.8 38722.4 39090.2 39341.4 46725.5 47267.3 49664.5 49964.3 50680.2 8505.3 8536.6 8587.5 8660.0 8754.4 12809.0 12820.4 12867.9 12989.8 13454.3 11467.9 11507.6 11617.1 12000.9 12092.5 11212.5 11320.4 11322.8 11432.4 11615.3 10342.0 10404.1 10869.4 11148.6 11633.2 8086.8 8289.8 8474.6 8507.1 8628.7 11342.0 11556.2 11763.6 12034.3 12074.8 17:17:13 INFO - PID 9150 | 17:17:13 INFO - PID 9150 | [#3] mootools.html Cycles:180 Average:5956.84 Median:4965.33 stddev:3731.24 (75.1%) stddev-sans-first:3725.07 17:17:13 INFO - PID 9150 | Values: 1267.8 1299.6 1305.5 1312.3 1318.1 8744.8 9041.0 9090.9 9175.7 9187.1 9070.1 9214.7 9306.0 9306.9 9324.1 2060.1 2095.6 2097.9 2142.0 2147.1 1998.2 2039.4 2078.8 2083.9 2085.9 1942.0 1950.1 1959.5 1965.8 2018.4 2008.7 2019.0 2020.6 2023.4 2024.2 1925.8 1987.3 2021.1 2034.8 2079.7 9230.0 9397.6 9401.7 9413.5 9447.4 5276.8 5447.6 5455.7 5469.2 5505.3 3095.2 3263.0 3268.2 3299.2 3311.4 1031.6 1064.3 1085.3 1119.6 1122.9 13387.7 13615.8 13626.5 13646.2 13696.5 4839.6 4995.4 5083.4 5109.5 5170.1 11476.3 11525.9 11573.5 11585.8 11586.7 5522.3 5538.5 5543.6 5551.2 5564.2 4703.0 4795.8 4865.1 4908.3 4941.2 4074.8 4084.1 4095.4 4102.0 4142.7 1314.3 1347.3 1353.8 1363.7 1389.1 687.3 707.6 718.3 727.1 730.7 5077.7 5128.9 5203.7 5289.3 5364.6 547.5 555.5 557.1 561.1 568.2 3144.4 3152.6 3184.8 3302.7 3677.5 11732.9 12315.6 12322.9 12370.9 12408.9 12130.4 12270.4 12299.0 12356.7 12379.8 7259.4 7284.6 7461.6 7461.7 7497.7 5684.7 5996.3 5999.3 6120.4 6264.1 10513.3 10902.6 10977.7 11024.1 11154.1 10982.5 11075.8 11112.2 11384.8 11509.9 7912.5 7966.2 8055.5 8091.4 8092.1 8744.2 8755.2 8780.3 8806.7 8812.9 7689.3 7817.8 8016.3 8057.1 8098.3 7492.5 7631.2 7655.8 7658.9 7770.5 6854.7 7043.9 7045.9 7048.0 7049.0 4989.4 5055.4 5107.8 5115.4 5155.6 5127.7 5160.4 5212.2 5305.3 5316.9 17:17:13 INFO - PID 9150 | 17:17:13 INFO - PID 9150 | [#4] prototype.html Cycles:180 Average:4822.53 Median:5466.47 stddev:1420.59 (26.0%) stddev-sans-first:1384.50 17:17:13 INFO - PID 9150 | Values: 358.8 368.8 373.6 382.1 387.9 5321.8 5518.5 5610.2 5629.3 5636.0 5318.3 5429.7 5464.4 5468.5 5482.1 4311.2 4313.0 4319.3 4321.2 4324.0 4244.2 4292.7 4293.6 4305.9 4337.4 4253.4 4264.0 4274.3 4275.2 4277.1 4260.3 4268.5 4274.4 4287.4 4294.3 3447.0 3896.8 3919.9 3921.4 3927.5 5214.0 5230.8 5256.1 5271.9 5311.7 4870.3 4880.4 4886.6 4889.0 4896.0 5586.0 5734.7 5785.2 5826.7 5834.4 4049.4 4057.7 4060.5 4062.6 4066.8 6031.8 6131.9 6150.4 6216.7 6233.4 4104.3 4110.3 4116.4 4116.7 4121.1 4174.2 4196.9 4199.8 4211.6 4218.2 4717.7 4815.5 4838.9 4839.5 4846.5 5828.6 5833.7 5847.3 5882.7 5883.4 1446.3 1454.7 1454.8 1455.4 1456.1 966.3 968.3 979.4 983.2 985.6 5088.4 5116.6 5117.4 5154.5 5173.9 5996.8 6002.5 6029.3 6031.4 6069.0 4981.3 5012.5 5080.9 5085.9 5133.7 3176.7 3183.5 3200.0 3202.6 3223.4 5354.6 5608.1 5626.4 5628.7 5637.2 6193.2 6228.8 6233.5 6241.3 6300.7 5654.2 5655.8 5656.4 5661.6 5675.5 5886.0 5947.6 6007.2 6019.4 6060.0 5926.1 5941.3 5943.3 5964.9 5967.7 5434.9 5584.3 5621.4 5633.4 5658.5 4105.9 4144.6 4152.5 4153.2 4172.1 5932.2 6034.7 6100.8 6105.6 6116.0 5848.7 5856.5 5879.2 5888.4 5893.2 5863.1 5866.6 5888.0 5892.5 5898.5 5719.4 5743.7 5791.9 5808.9 5816.1 5885.6 5908.3 5914.0 5919.8 5937.3 5626.5 5705.0 5730.9 5742.1 5757.7 17:17:13 INFO - PID 9150 | 17:17:13 INFO - PID 9150 | [#5] yui.html Cycles:180 Average:14710.52 Median:31338.11 stddev:17083.70 (54.5%) stddev-sans-first:17099.48 17:17:13 INFO - PID 9150 | Values: 755.1 764.2 775.1 785.1 788.6 12075.4 12302.9 14072.7 14501.3 14570.7 12544.3 15066.5 15539.8 15563.3 15616.8 895.8 925.3 925.4 926.1 928.2 925.9 928.8 936.6 938.7 938.8 973.6 979.3 979.6 979.6 980.7 968.0 968.8 970.8 971.0 973.7 711.2 713.4 714.2 716.2 717.0 14201.4 14270.7 14977.4 15249.4 15299.3 15577.5 15629.5 15872.5 15926.2 16108.9 11398.7 11545.2 11606.3 11676.4 11692.2 2576.1 2606.2 2612.9 2621.1 2625.3 65373.0 66184.3 66448.0 67526.7 68561.7 10937.3 10977.1 11044.8 11162.8 11196.2 17634.5 17911.4 18049.0 18120.8 18321.0 6055.1 6283.6 6475.6 6497.1 6518.3 2887.7 2908.4 2927.9 2928.0 2936.1 3382.5 3418.1 3418.8 3458.9 3462.4 673.8 679.1 681.6 684.0 685.4 571.9 577.8 579.1 582.7 602.0 8959.4 9538.0 9543.3 9617.7 9931.7 621.0 638.5 639.4 649.5 658.1 4246.3 4356.6 4395.8 4416.5 4512.3 60331.7 60645.4 60862.7 62857.4 62925.7 51458.0 52064.7 52069.2 54828.7 58592.7 45696.1 47028.5 47667.3 50228.0 50484.7 10369.2 10801.9 10912.2 11034.1 11084.8 26326.9 26599.3 26654.7 27234.2 27689.0 31151.0 31525.2 31582.0 31900.8 32378.4 13467.5 13763.2 13891.1 13960.4 14025.8 13274.9 14889.0 15206.2 16005.6 16438.3 13723.0 13775.5 13923.2 13996.8 14263.0 13405.8 14185.9 14200.9 14204.6 14275.0 13694.9 13885.5 13935.4 14012.6 14251.7 10094.9 10887.5 11103.2 11349.9 11498.0 11360.9 11753.3 11834.9 11874.3 12065.5 17:17:13 INFO - PID 9150 | -------- Summary: end -------- 17:17:13 INFO - PID 9150 | 17:17:14 INFO - TEST-INFO | 9150: exit 0 17:17:14 INFO - TEST-OK | dromaeo_css | took 1119026ms 17:17:14 INFO - TEST-START | kraken 17:17:14 INFO - operating with platform_type : linux_ 17:17:14 INFO - Initialising browser for kraken test... 17:17:14 INFO - TEST-INFO | started process 9592 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg3LlOT/profile http://localhost:55687/getInfo.html) 17:17:18 INFO - PID 9592 | __metrics Screen width/height:1600/1200 17:17:18 INFO - PID 9592 | colorDepth:24 17:17:18 INFO - PID 9592 | Browser inner width/height: 1024/695 17:17:18 INFO - PID 9592 | __metrics 17:17:20 INFO - TEST-INFO | 9592: exit 0 17:17:20 INFO - Browser initialized. 17:17:20 INFO - Running cycle 1/1 for kraken test... 17:17:20 INFO - TEST-INFO | started process 9783 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg3LlOT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:17:32 INFO - PID 9783 | RSS: Main: 172625920 17:17:32 INFO - PID 9783 | 17:17:35 INFO - PID 9783 | Cycle 1(1): loaded http://localhost:55687/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55687/tests/kraken/driver.html?testName=audio-beat-detection) 17:17:36 INFO - PID 9783 | RSS: Main: 181661696 17:17:36 INFO - PID 9783 | 17:17:39 INFO - PID 9783 | Cycle 1(1): loaded http://localhost:55687/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55687/tests/kraken/driver.html?testName=audio-dft) 17:17:39 INFO - PID 9783 | RSS: Main: 180654080 17:17:39 INFO - PID 9783 | 17:17:42 INFO - PID 9783 | Cycle 1(1): loaded http://localhost:55687/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55687/tests/kraken/driver.html?testName=audio-fft) 17:17:43 INFO - PID 9783 | RSS: Main: 177598464 17:17:43 INFO - PID 9783 | 17:17:45 INFO - PID 9783 | Cycle 1(1): loaded http://localhost:55687/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55687/tests/kraken/driver.html?testName=audio-oscillator) 17:17:46 INFO - PID 9783 | RSS: Main: 178548736 17:17:46 INFO - PID 9783 | 17:17:48 INFO - PID 9783 | Cycle 1(1): loaded http://localhost:55687/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55687/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:17:48 INFO - PID 9783 | RSS: Main: 178954240 17:17:48 INFO - PID 9783 | 17:17:51 INFO - PID 9783 | Cycle 1(1): loaded http://localhost:55687/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55687/tests/kraken/driver.html?testName=imaging-darkroom) 17:17:52 INFO - PID 9783 | RSS: Main: 183357440 17:17:52 INFO - PID 9783 | 17:17:56 INFO - PID 9783 | Cycle 1(1): loaded http://localhost:55687/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55687/tests/kraken/driver.html?testName=imaging-desaturate) 17:17:56 INFO - PID 9783 | RSS: Main: 182087680 17:17:56 INFO - PID 9783 | 17:17:59 INFO - PID 9783 | Cycle 1(1): loaded http://localhost:55687/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55687/tests/kraken/driver.html?testName=json-parse-financial) 17:18:00 INFO - PID 9783 | RSS: Main: 183136256 17:18:00 INFO - PID 9783 | 17:18:01 INFO - PID 9783 | Cycle 1(1): loaded http://localhost:55687/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55687/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:18:02 INFO - PID 9783 | RSS: Main: 184471552 17:18:02 INFO - PID 9783 | 17:18:04 INFO - PID 9783 | Cycle 1(1): loaded http://localhost:55687/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55687/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:18:04 INFO - PID 9783 | RSS: Main: 185135104 17:18:04 INFO - PID 9783 | 17:18:07 INFO - PID 9783 | Cycle 1(1): loaded http://localhost:55687/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55687/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:18:07 INFO - PID 9783 | RSS: Main: 185094144 17:18:07 INFO - PID 9783 | 17:18:10 INFO - PID 9783 | Cycle 1(1): loaded http://localhost:55687/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55687/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:18:11 INFO - PID 9783 | RSS: Main: 184655872 17:18:11 INFO - PID 9783 | 17:18:14 INFO - PID 9783 | Cycle 1(1): loaded http://localhost:55687/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55687/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:18:15 INFO - PID 9783 | RSS: Main: 183975936 17:18:15 INFO - PID 9783 | 17:18:16 INFO - PID 9783 | Cycle 1(1): loaded http://localhost:55687/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55687/tests/kraken/driver.html?testName=ai-astar) 17:18:17 INFO - PID 9783 | RSS: Main: 186195968 17:18:17 INFO - PID 9783 | 17:18:17 INFO - PID 9783 | __start_tp_report 17:18:17 INFO - PID 9783 | _x_x_mozilla_page_load 17:18:17 INFO - PID 9783 | _x_x_mozilla_page_load_details 17:18:17 INFO - PID 9783 | |i|pagename|runs| 17:18:17 INFO - PID 9783 | |0;ai-astar;104;112;112;113;114;113;113;115;113;112 17:18:17 INFO - PID 9783 | |1;audio-beat-detection;147;126;125;162;122;124;124;124;147;123 17:18:17 INFO - PID 9783 | |2;audio-dft;163;165;168;166;170;171;169;163;164;164 17:18:17 INFO - PID 9783 | |3;audio-fft;75;76;77;113;75;74;76;76;91;76 17:18:17 INFO - PID 9783 | |4;audio-oscillator;83;82;104;84;85;83;99;83;83;110 17:18:17 INFO - PID 9783 | |5;imaging-gaussian-blur;114;118;114;114;114;114;114;118;114;115 17:18:17 INFO - PID 9783 | |6;imaging-darkroom;153;151;152;151;150;151;150;151;155;152 17:18:17 INFO - PID 9783 | |7;imaging-desaturate;95;95;94;94;95;95;94;95;96;94 17:18:17 INFO - PID 9783 | |8;json-parse-financial;55;59;65;56;58;55;55;55;55;54 17:18:17 INFO - PID 9783 | |9;json-stringify-tinderbox;55;56;56;55;56;55;56;55;55;55 17:18:17 INFO - PID 9783 | |10;stanford-crypto-aes;81;81;83;84;83;82;82;86;82;82 17:18:17 INFO - PID 9783 | |11;stanford-crypto-ccm;134;140;131;129;148;132;131;135;189;140 17:18:17 INFO - PID 9783 | |12;stanford-crypto-pbkdf2;181;191;193;190;190;188;198;186;196;193 17:18:17 INFO - PID 9783 | |13;stanford-crypto-sha256-iterative;72;71;77;73;75;77;70;74;73;69 17:18:17 INFO - PID 9783 | __end_tp_report 17:18:17 INFO - PID 9783 | __start_cc_report 17:18:17 INFO - PID 9783 | _x_x_mozilla_cycle_collect,830 17:18:17 INFO - PID 9783 | __end_cc_report 17:18:17 INFO - PID 9783 | __startTimestamp1494029897093__endTimestamp 17:18:17 INFO - PID 9783 | 17:18:17 INFO - PID 9783 | ------- Summary: start ------- 17:18:17 INFO - PID 9783 | Number of tests: 14 17:18:17 INFO - PID 9783 | 17:18:17 INFO - PID 9783 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:3.00 (2.7%) stddev-sans-first:1.00 17:18:17 INFO - PID 9783 | Values: 104.0 112.0 112.0 113.0 114.0 113.0 113.0 115.0 113.0 112.0 17:18:17 INFO - PID 9783 | 17:18:17 INFO - PID 9783 | [#1] audio-beat-detection Cycles:10 Average:132.40 Median:125.50 stddev:14.17 (11.3%) stddev-sans-first:14.01 17:18:17 INFO - PID 9783 | Values: 147.0 126.0 125.0 162.0 122.0 124.0 124.0 124.0 147.0 123.0 17:18:17 INFO - PID 9783 | 17:18:17 INFO - PID 9783 | [#2] audio-dft Cycles:10 Average:166.30 Median:167.00 stddev:2.98 (1.8%) stddev-sans-first:2.92 17:18:17 INFO - PID 9783 | Values: 163.0 165.0 168.0 166.0 170.0 171.0 169.0 163.0 164.0 164.0 17:18:17 INFO - PID 9783 | 17:18:17 INFO - PID 9783 | [#3] audio-fft Cycles:10 Average:80.90 Median:76.00 stddev:12.30 (16.2%) stddev-sans-first:12.86 17:18:17 INFO - PID 9783 | Values: 75.0 76.0 77.0 113.0 75.0 74.0 76.0 76.0 91.0 76.0 17:18:17 INFO - PID 9783 | 17:18:17 INFO - PID 9783 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:83.00 stddev:10.52 (12.7%) stddev-sans-first:10.89 17:18:17 INFO - PID 9783 | Values: 83.0 82.0 104.0 84.0 85.0 83.0 99.0 83.0 83.0 110.0 17:18:17 INFO - PID 9783 | 17:18:17 INFO - PID 9783 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:114.00 stddev:1.66 (1.5%) stddev-sans-first:1.73 17:18:17 INFO - PID 9783 | Values: 114.0 118.0 114.0 114.0 114.0 114.0 114.0 118.0 114.0 115.0 17:18:17 INFO - PID 9783 | 17:18:17 INFO - PID 9783 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:151.50 stddev:1.51 (1.0%) stddev-sans-first:1.51 17:18:17 INFO - PID 9783 | Values: 153.0 151.0 152.0 151.0 150.0 151.0 150.0 151.0 155.0 152.0 17:18:17 INFO - PID 9783 | 17:18:17 INFO - PID 9783 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 17:18:17 INFO - PID 9783 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 94.0 95.0 96.0 94.0 17:18:17 INFO - PID 9783 | 17:18:17 INFO - PID 9783 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:55.50 stddev:3.30 (5.9%) stddev-sans-first:3.44 17:18:17 INFO - PID 9783 | Values: 55.0 59.0 65.0 56.0 58.0 55.0 55.0 55.0 55.0 54.0 17:18:17 INFO - PID 9783 | 17:18:17 INFO - PID 9783 | [#9] json-stringify-tinderbox Cycles:10 Average:55.40 Median:55.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 17:18:17 INFO - PID 9783 | Values: 55.0 56.0 56.0 55.0 56.0 55.0 56.0 55.0 55.0 55.0 17:18:17 INFO - PID 9783 | 17:18:17 INFO - PID 9783 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.50 stddev:1.51 (1.8%) stddev-sans-first:1.48 17:18:17 INFO - PID 9783 | Values: 81.0 81.0 83.0 84.0 83.0 82.0 82.0 86.0 82.0 82.0 17:18:17 INFO - PID 9783 | 17:18:17 INFO - PID 9783 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:137.50 stddev:17.84 (13.0%) stddev-sans-first:18.75 17:18:17 INFO - PID 9783 | Values: 134.0 140.0 131.0 129.0 148.0 132.0 131.0 135.0 189.0 140.0 17:18:17 INFO - PID 9783 | 17:18:17 INFO - PID 9783 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.60 Median:192.00 stddev:4.90 (2.6%) stddev-sans-first:3.77 17:18:17 INFO - PID 9783 | Values: 181.0 191.0 193.0 190.0 190.0 188.0 198.0 186.0 196.0 193.0 17:18:17 INFO - PID 9783 | 17:18:17 INFO - PID 9783 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:73.50 stddev:2.73 (3.7%) stddev-sans-first:2.86 17:18:17 INFO - PID 9783 | Values: 72.0 71.0 77.0 73.0 75.0 77.0 70.0 74.0 73.0 69.0 17:18:17 INFO - PID 9783 | -------- Summary: end -------- 17:18:17 INFO - PID 9783 | 17:18:18 INFO - TEST-INFO | 9783: exit 0 17:18:18 INFO - TEST-OK | kraken | took 63776ms 17:18:18 INFO - SUITE-END | took 1182s 17:18:18 INFO - Completed test suite (00:19:43) 17:18:18 INFO - javascript benchmark 17:18:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6659.860474209975, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2731.3035176030107, 2733.125399872041, 2762.2403838944288, 2769.5707165389344, 2773.1680495851247, 5044.82343117991, 5077.644564880456, 5120.718360490177, 5134.897302053957, 5136.512031357015, 5146.768395422206, 5168.61235407345, 5190.766415511302, 5265.7893684252585, 5271.262023316739, 4380.92860708936, 4600.907981840362, 4609.562091601292, 4614.700044497114, 4632.791524381394, 4639.65202609804, 4666.580007799297, 4688.2264426369775, 4720.433547974248, 4725.149473094842, 4504.527024662396, 4539.387182730322, 4552.726836389827, 4582.03777206787, 4632.745199014053, 4571.456996468182, 4597.885052873671, 4601.5168407317415, 4617.792199351037, 4642.651801114896, 4537.591616754475, 4538.228501154778, 4547.522510136421, 4597.126545956257, 4645.907081858344, 5037.5214354636255, 5085.567726743231, 5097.23541468779, 5101.566366858784, 5109.770060347293, 5534.695591742453, 5591.9720401398135, 5661.122526008434, 5677.120046392815, 5678.977783998878, 5606.074997625387, 5609.9902017636805, 5619.044762390404, 5619.775208991636, 5624.690642014688, 5138.820141295111, 5161.458046905096, 5162.5095615916425, 5162.767675454614, 5171.793128274902, 5626.409227031185, 5688.715564221772, 5702.971485142548, 5710.8001219957105, 5766.711664416763, 5375.892482150335, 5459.645123066988, 5464.590155738336, 5465.9180112298345, 5467.863303417446, 5552.222688823568, 5611.046122159243, 5623.156526521055, 5624.55003599711, 5636.520895723827, 5548.944510554924, 5558.138488534284, 5566.526845218121, 5569.944300556943, 5582.525485333792, 5535.418781028015, 5552.222688823568, 5553.750081246354, 5554.805581804618, 5562.944370556243, 4601.746903920316, 4609.377734005866, 4620.283856002325, 4630.421197350332, 4631.166390049823, 3552.946705799415, 4047.129867078533, 4056.127932494528, 4092.5907409258834, 4102.528209255914, 4816.54242846929, 4822.493638167942, 4822.565969062801, 4834.854954351375, 4891.755412229374, 5625.606207565431, 5644.604877658607, 5664.546836253172, 5666.15007748841, 5668.773249069991, 4741.288806679026, 4765.642576806753, 4824.589909857631, 4865.5864251538305, 4871.342368780241, 4832.154372984784, 4894.657373983787, 4950.851474455772, 4975.0547395994645, 4976.975115124401, 5152.407473140487, 5153.768080436314, 5199.948000519947, 5202.297689811827, 5211.635185537052, 5522.0, 5546.251256080377, 5548.69482178484, 5548.889022219452, 5575.4424557543925, 5138.820141295187, 5165.638405311592, 5235.581153507634, 5279.26090347344, 5282.81510147143, 5464.26232458613, 5507.476789704971, 5508.586855985737, 5525.419830917695, 5572.136318870582, 5606.24315717373, 5608.831735047955, 5612.550995920398, 5623.156526521055, 5625.943740562542, 5303.443138470405, 5334.973325133349, 5409.675419474844, 5488.957098151339, 5499.862503437446, 5249.763760630857, 5484.8354549363585, 5491.093969494988, 5495.862603434946, 5534.557235421237, 5368.0, 5417.891642167056, 5418.620696551204, 5419.268398766116, 5475.425080366664, 5383.2463455117095, 5401.297831281908, 5485.040117979258, 5526.751296191762, 5539.723013849372, 5387.407385187705, 5390.676559406448, 5391.946080539301, 5427.891442171055, 5459.153831156177], "value": 5062.81091597435, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.4528831646367, 747.3647399710247, 757.7461550380622, 1081.6160263106597, 1083.349990005996, 29235.122946311618, 30196.3960720786, 30246.09261722149, 30257.09228723139, 30262.84868575654, 31383.21541961452, 31702.524462133086, 31744.68255317446, 31776.20559486014, 31905.68094319056, 6823.147106611674, 6839.555428897118, 6951.096357473547, 6971.442284617244, 7001.684924178398, 6921.100256966587, 6971.477139214579, 6996.195437524699, 6997.195322537897, 7039.542429742076, 6985.5110142289805, 7037.507374483788, 7087.610181440019, 7090.113735783028, 7100.112485939258, 7025.19210290818, 7025.543339682904, 7051.25961774014, 7061.1173603299585, 7075.186353569354, 6909.343612356868, 6976.93023069773, 6981.755638552626, 6984.720611175598, 6987.650617469106, 31897.681023189703, 32005.839970799996, 32036.199095022577, 32057.83971080153, 32104.6789532104, 3005.8046226995175, 3051.282948507121, 3056.6484854241826, 3057.9541306880415, 3070.3245286037036, 24261.393465163514, 24376.268711938672, 24453.8428467161, 24570.262892113264, 24600.384990375205, 3039.224997625591, 3068.6624471308137, 3073.462144124769, 3092.4279008383296, 3131.9530207046914, 137431.0, 137889.3105534476, 151262.0, 155530.0, 155876.0, 40154.59845401509, 40187.0, 40353.596464035574, 40469.59530404658, 40507.59492405097, 41513.58486415097, 41654.58345416507, 41739.165216695495, 41938.37092443616, 41975.0, 12043.458044388024, 12090.6700262971, 12091.395430228453, 12095.75808483843, 12124.090693198046, 9418.434893906388, 9431.575579098957, 9445.716628501155, 9448.57481413338, 9485.430874147436, 12742.36288185587, 12775.488980440865, 12820.935895320463, 12846.0, 12857.678558035937, 5230.227979171045, 5312.495312945264, 5319.388270348882, 5369.785208591691, 5384.784608615611, 798.7603718884311, 824.8020475085937, 857.1557016338901, 859.072202021815, 860.2214995429147, 18869.716954245698, 18984.62030759377, 19807.60384792296, 20072.490938632673, 20154.39536813898, 906.428949761646, 910.4764760262875, 924.3160061554402, 930.2557953637063, 946.2619157057507, 10134.341267817568, 10277.126444252173, 10474.68575942723, 10684.412357320267, 10730.570777168981, 183695.0, 185123.0, 186494.0, 186677.0666146688, 186754.0, 40958.18083638311, 41430.37854432186, 41485.0, 41518.58481415147, 41554.37668434976, 1222.9266244025387, 1267.309316422552, 1268.194696367813, 1275.2922128218743, 1279.4818098670053, 18466.35367762122, 18876.33932812345, 23017.0, 24578.877105614356, 24740.0, 38689.2262154761, 39073.804630976665, 39106.80446597749, 39176.804115980376, 39376.803115984236, 163316.0, 163833.0, 164636.0, 164819.0, 165505.0, 29983.400331993675, 30270.84864575663, 30870.69129308768, 30949.535756964113, 31055.223619409695, 35634.64365356417, 36800.0, 36813.07967300839, 36853.26293474062, 37010.0, 27434.862825685745, 27459.0, 27964.161075166965, 28539.143825685263, 29022.709772902002, 27764.722352776214, 27945.580816287365, 27971.0, 29171.270718231364, 29201.70798292075, 29971.0, 30418.695813042472, 30975.535366969063, 31012.53481197829, 31350.843245783624, 27267.909283629226, 27287.181384558495, 27482.725172748018, 27867.0, 28783.424331512833, 21046.0, 22565.5486890258, 22617.66073508866, 22878.31365059051, 22907.656385153903], "value": 14554.032816104436, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.6914379643369, 414.9709520333578, 418.284733106388, 430.6533240741204, 433.3845938766951, 14785.408583656654, 14851.257437128155, 15273.694526109484, 15401.845981540182, 15908.045517268973, 17663.205155767988, 18013.0, 18235.817641823578, 18318.542036449096, 18369.265229390843, 5333.519983201511, 5392.676439413638, 5532.114861622142, 5548.500634942854, 5551.944480555203, 5400.378956420022, 5485.506304432601, 5524.33707955044, 5534.916976245359, 5542.057850165482, 5222.582193424536, 5443.891122177574, 5461.2354270401975, 5493.066178749622, 5503.229547863302, 5363.8122665706705, 5419.024575576375, 5424.593155513333, 5433.538149257318, 5458.153986132156, 4894.0, 4904.901901961941, 4911.926321105187, 4913.385826771653, 4915.361003069578, 21510.462238444008, 21626.35120946374, 21655.0, 21673.891630541904, 22010.559788804294, 1534.7314220011453, 1548.0866288889497, 1561.0165595674766, 1563.335582377485, 1564.5150003498952, 14297.571072867831, 14904.850951490454, 14906.776398354034, 14968.0, 14970.62573435662, 2089.613421517024, 2114.6510825713895, 2143.6677315016195, 2169.9240526581652, 2172.196287373666, 93019.53490232573, 94482.52758736162, 94621.67465115526, 94821.0, 95494.0, 11143.442827858575, 11189.328640281446, 11431.485583148778, 11445.771084578262, 11508.88491115078, 15503.84496155024, 15566.377344906303, 15568.922155389377, 15581.298841552158, 15615.687686246212, 7441.144268409203, 7510.6620202091035, 7687.500312479671, 7693.576853273124, 7711.614419279126, 6933.2720064393525, 6952.617606031717, 6980.7905762827195, 7111.2533184015965, 7153.570785752871, 6948.200956889921, 6958.965205173941, 7086.866101423748, 7087.291270872872, 7119.857602847914, 2070.5755320159633, 2075.3773867839586, 2080.573482436097, 2087.6242276390094, 2196.1874106580667, 877.5524482513964, 903.8101998580372, 908.3777612335572, 911.5533388639651, 928.9907100928904, 17038.74441883373, 17109.828901711073, 17914.0, 17922.820771792376, 18138.274469021093, 904.1230006893303, 910.3721669148438, 913.2921985461321, 913.7806926337631, 927.2442958988403, 9641.42151470914, 9647.71056868295, 9832.705018849447, 9887.0, 10091.545880435398, 378347.0, 379214.0, 382251.0, 382580.0, 386615.0, 76474.0, 77668.61165694248, 78495.0, 78649.0, 81433.59283203546, 1083.4853444613746, 1090.4384242115316, 1100.664297389304, 1107.4329823300102, 1111.6220485034964, 14957.775633365725, 15089.320980555682, 15354.539363819104, 15473.84526154724, 15521.223938802788, 38089.6191038086, 38387.80806095952, 38722.41916371313, 39090.218195636495, 39341.40987885241, 46725.53274467212, 47267.290990635855, 49664.503354965986, 49964.25053624271, 50680.23979640235, 8505.277051450448, 8536.573171341532, 8587.484750914966, 8659.956700216711, 8754.410691616407, 12809.0, 12820.423080961566, 12867.871321287043, 12989.805152922525, 13454.26001569923, 11467.942660286646, 11507.597234097102, 11617.128715346214, 12000.919917207493, 12092.45583948742, 11212.495437705486, 11320.37737924422, 11322.830157547478, 11432.428378581204, 11615.303081815118, 10342.0, 10404.11565016982, 10869.402182880018, 11148.609798657008, 11633.243839150766, 8086.757397278091, 8289.83420331602, 8474.61864216124, 8507.149285071691, 8628.654853805778, 11342.0, 11556.191066625255, 11763.588274410355, 12034.277943323428, 12074.75850483003], "value": 8909.758634221193, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1267.7718010758063, 1299.6425982854714, 1305.5169587252706, 1312.343828085957, 1318.1497933832677, 8744.825103497926, 9040.954795226015, 9090.863637045433, 9175.678851240207, 9187.081291870809, 9070.092990700943, 9214.677486287981, 9305.95347023264, 9306.906930930705, 9324.11420915012, 2060.0935588341117, 2095.6437405641, 2097.874127552344, 2141.9785802141937, 2147.055295669908, 1998.2107067708246, 2039.449348675864, 2078.771335153132, 2083.8853863037525, 2085.8748475091543, 1941.9902900485479, 1950.112698722078, 1959.500327416514, 1965.7542807149107, 2018.444927644902, 2008.6786114221727, 2019.0409555461038, 2020.5756791073893, 2023.4132101690493, 2024.2307922989316, 1925.8266755991888, 1987.2746447546685, 2021.1208124465904, 2034.8270397016272, 2079.7088407622946, 9229.98470168281, 9397.57710903011, 9401.717948461557, 9413.529323533865, 9447.433154010781, 5276.7889284428575, 5447.618666693333, 5455.699936503491, 5469.15228139635, 5505.311836020497, 3095.1797773590015, 3263.0, 3268.215628249227, 3299.224682199681, 3311.403947289487, 1031.6131450705984, 1064.3081996702128, 1085.2565992295304, 1119.5577746789972, 1122.9438528073645, 13387.732245355135, 13615.795763063563, 13626.454941802316, 13646.2494562799, 13696.52062177819, 4839.564439200419, 4995.350604421402, 5083.364579427572, 5109.489051094861, 5170.069387510209, 11476.254043487146, 11525.88474115265, 11573.479193436315, 11585.76828463426, 11586.652400428, 5522.2544956431175, 5538.47384498472, 5543.584231182677, 5551.168114522198, 5564.221009058735, 4702.95297047032, 4795.808167673254, 4865.0756356292895, 4908.337374454474, 4941.234108713155, 4074.7571990542574, 4084.0869965812494, 4095.3856921461424, 4101.979490102531, 4142.668586513072, 1314.3231235913513, 1347.3263368315843, 1353.7563238616947, 1363.7068030373516, 1389.1109689798536, 687.2611942162196, 707.6072779607265, 718.3140101203338, 727.149235394579, 730.7113690092384, 5077.695338279715, 5128.897422051613, 5203.687778733288, 5289.338832645919, 5364.597655175878, 547.4935684491829, 555.5278013688413, 557.1141884403818, 561.147056474157, 568.1591244957486, 3144.371125774854, 3152.621685397767, 3184.8407579620925, 3302.7192688621735, 3677.485152078711, 11732.94133529327, 12315.568955086528, 12322.876771232173, 12370.876291237153, 12408.875911240953, 12130.393480325949, 12270.38648067593, 12299.0, 12356.691082723004, 12379.75240495185, 7259.382952448996, 7284.599347035964, 7461.552306861606, 7461.664225109883, 7497.700091996368, 5684.7157642118555, 5996.340402555803, 5999.310079340931, 6120.44915957566, 6264.060390941395, 10513.264071514921, 10902.618408355669, 10977.725556861142, 11024.118070554176, 11154.107671386108, 10982.450877456255, 11075.83386249223, 11112.22214444981, 11384.772304554028, 11509.942450287695, 7912.525248485109, 7966.16355282687, 8055.476394034369, 8091.433599647969, 8092.109867914407, 8744.213020828156, 8755.212030917248, 8780.341474389574, 8806.691765788166, 8812.867806982773, 7689.269519395649, 7817.82732590116, 8016.318612917968, 8057.113717490954, 8098.3116435103675, 7492.51298665585, 7631.236876312324, 7655.808604784925, 7658.885116723142, 7770.533767973713, 6854.657267136524, 7043.859122817617, 7045.894311585228, 7048.0, 7048.977898204629, 4989.426215985208, 5055.393352797688, 5107.846764597068, 5115.360579927509, 5155.587552995827, 5127.692338459704, 5160.406553246275, 5212.192110222922, 5305.31030965972, 5316.8936621266585], "value": 4510.234875767991, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.81700332830246, 368.8303380444995, 373.6151763683407, 382.1192152089434, 387.9243547508236, 5321.787128514855, 5518.530924871381, 5610.158476228567, 5629.268195134632, 5636.0, 5318.282031925689, 5429.728513574325, 5464.4262352453015, 5468.507834294913, 5482.122860342346, 4311.159323931826, 4312.986448184674, 4319.33050377192, 4321.157374312011, 4324.0, 4244.1511697660435, 4292.720973136752, 4293.613574778269, 4305.935410968838, 4337.414449049369, 4253.447051883266, 4264.0, 4274.294741367687, 4275.166342563201, 4277.101808620194, 4260.275753121977, 4268.530461649216, 4274.444322238121, 4287.442632457761, 4294.291441912081, 3446.9831399737136, 3896.844126234947, 3919.9216015679813, 3921.4313924481075, 3927.528696556403, 5214.0, 5230.790768369261, 5256.106461901486, 5271.894562108736, 5311.654742441768, 4870.342503761982, 4880.438749543812, 4886.560209581119, 4889.046635906, 4895.9755201224125, 5585.972070139664, 5734.684592347419, 5785.2189954356045, 5826.708664566755, 5834.4165583441745, 4049.372347286146, 4057.7159598828093, 4060.47213862199, 4062.593740625943, 4066.79666016698, 6031.8190454286005, 6131.908021379728, 6150.3553472007015, 6216.720247588869, 6233.407826256498, 4104.322786740214, 4110.321796903538, 4116.444280022159, 4116.650084742831, 4121.093359460914, 4174.20690068886, 4196.9370459443135, 4199.811008504625, 4211.642010429086, 4218.240716671029, 4717.693349932312, 4815.470298267188, 4838.927416088762, 4839.516048395203, 4846.473360891308, 5828.562857785683, 5833.7374818133285, 5847.298324201123, 5882.705804722954, 5883.352831188566, 1446.2696338349067, 1454.6799704065088, 1454.7817827325987, 1455.3960106555874, 1456.1336005077173, 966.3380584299778, 968.3366893677712, 979.4417182206216, 983.2232536296245, 985.6008316631776, 5088.363954505687, 5116.590672746172, 5117.360329958755, 5154.510321519525, 5173.922391164136, 5996.820095397145, 6002.519798416116, 6029.306629737549, 6031.4270144336215, 6069.0, 4981.252812078217, 5012.498750124958, 5080.891430056559, 5085.949140508547, 5133.717645529457, 3176.7451856516545, 3183.5065564837487, 3200.023992682254, 3202.5836641236956, 3223.403670320998, 5354.598405119632, 5608.10270356741, 5626.38109807929, 5628.662280263197, 5637.238972738628, 6193.225846769154, 6228.844278893064, 6233.532485063638, 6241.313455519889, 6300.653464059429, 5654.151877218368, 5655.830325090254, 5656.43435656431, 5661.575381846295, 5675.5459563234845, 5885.970570147122, 5947.643141411356, 6007.158997740407, 6019.398060193946, 6059.969700151471, 5926.111083337534, 5941.257342832146, 5943.257092863392, 5964.940350596438, 5967.671778052075, 5434.918476222939, 5584.268876648252, 5621.353544342453, 5633.352164501135, 5658.490735833795, 4105.938410923898, 4144.647704945113, 4152.5466086870565, 4153.231652144363, 4172.102997855475, 5932.203389830598, 6034.69826508664, 6100.786472473442, 6105.572609917441, 6116.0, 5848.707564621837, 5856.502197313106, 5879.176915231957, 5888.411158884077, 5893.204417403767, 5863.061910094364, 5866.5893387462465, 5887.970560147171, 5892.528597712087, 5898.469137777621, 5719.399463056319, 5743.712814359349, 5791.884162316815, 5808.883822323614, 5816.127580862735, 5885.646861188342, 5908.291005079418, 5913.994620914369, 5919.822405327847, 5937.3468918418075, 5626.465485778845, 5705.0, 5730.879574557441, 5742.138679198154, 5757.7121143941795], "value": 4379.5891358715635, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.1202848681287, 764.2204950950031, 775.1086250811562, 785.1167436633787, 788.6056971514241, 12075.396230188499, 12302.876971230286, 14072.71854562908, 14501.347439365241, 14570.708585828277, 12544.310062946557, 15066.54800355991, 15539.844601553981, 15563.299651515681, 15616.84383156168, 895.7850115972169, 925.2597921662676, 925.3568769705058, 926.0693003531475, 928.2388441477991, 925.8935222449403, 928.7910220200469, 936.5504557812254, 938.6620816506087, 938.8122375524888, 973.6251543155865, 979.3389462113081, 979.5738853598672, 979.6277414582485, 980.6763767956558, 968.0271327316037, 968.8062387522453, 970.8058388322329, 970.9611615535371, 973.7078876337071, 711.2176605733652, 713.4470785141505, 714.1537278325201, 716.151360637646, 716.9964150179268, 14201.360938757678, 14270.714585708227, 14977.400903963828, 15249.39002439901, 15299.311530981133, 15577.454789082327, 15629.452969146025, 15872.52382428529, 15926.203689815462, 16108.919455402647, 11398.658040258806, 11545.191836571443, 11606.303621782636, 11676.357800320979, 11692.240004399688, 2576.059738195564, 2606.2181345596246, 2612.8562929038894, 2621.1350254415997, 2625.3174174714522, 65373.0, 66184.3381566183, 66448.0, 67526.66236668834, 68561.65719171372, 10937.343759374464, 10977.12183025356, 11044.834327485094, 11162.832557511643, 11196.160287978435, 17634.470965871045, 17911.373101941368, 18049.0, 18120.818791811915, 18321.0, 6055.061465472859, 6283.622982621057, 6475.611463312216, 6497.090407342976, 6518.28298887122, 2887.6967918368687, 2908.4328555931816, 2927.8828846846313, 2928.03374886287, 2936.0604606526135, 3382.5433566468705, 3418.0600334907604, 3418.7948723076697, 3458.913527161841, 3462.3594634992605, 673.7978606418055, 679.1035832700787, 681.5944513014748, 683.9658017099225, 685.4413652872893, 571.9370869204384, 577.7717801468481, 579.1052823387876, 582.7465052702004, 602.036741214054, 8959.41623350665, 9537.952310238405, 9543.33196676226, 9617.71146865595, 9931.65239216624, 620.9968950155311, 638.5434414393638, 639.4404895716249, 649.4577028181427, 658.0589756648039, 4246.256905041605, 4356.564343565618, 4395.846145384896, 4416.514183439884, 4512.323151527297, 60331.69834150889, 60645.39354606398, 60862.695686521285, 62857.37142628515, 62925.68537157285, 51458.0, 52064.739676301375, 52069.218961715604, 54828.72585637046, 58592.7070364654, 45696.13171355469, 47028.52971470242, 47667.284990725166, 50228.0, 50484.74757626262, 10369.216015343958, 10801.945990269998, 10912.181586380895, 11034.117270618171, 11084.833727493933, 26326.86836565805, 26599.335016623965, 26654.733452665227, 27234.182974510797, 27689.0, 31151.0, 31525.21186970252, 31582.0, 31900.840495797373, 32378.35243295168, 13467.461301548221, 13763.174209547458, 13891.097078689852, 13960.441582336593, 14025.789613155606, 13274.867251327363, 14889.032212906126, 15206.163660998309, 16005.599860003593, 16438.260278287744, 13723.039387242798, 13775.517856874962, 13923.164610123426, 13996.790048149489, 14263.0, 13405.798913016508, 14185.858141418867, 14200.928995354958, 14204.644883877985, 14275.0, 13694.93152534231, 13885.514007009706, 13935.442582297, 14012.579622611338, 14251.714965700836, 10094.949525252327, 10887.455627218449, 11103.16726245551, 11349.943250283695, 11498.022668073307, 11360.886391135982, 11753.294802311888, 11834.881651183377, 11874.287542747463, 12065.457054432396], "value": 6727.9718073929735, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 112.0, 113.0, 114.0, 113.0, 113.0, 115.0, 113.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 126.0, 125.0, 162.0, 122.0, 124.0, 124.0, 124.0, 147.0, 123.0], "value": 132.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 168.0, 166.0, 170.0, 171.0, 169.0, 163.0, 164.0, 164.0], "value": 166.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 113.0, 75.0, 74.0, 76.0, 76.0, 91.0, 76.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 104.0, 84.0, 85.0, 83.0, 99.0, 83.0, 83.0, 110.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 118.0, 114.0, 114.0, 114.0, 114.0, 114.0, 118.0, 114.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 152.0, 151.0, 150.0, 151.0, 150.0, 151.0, 155.0, 152.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 96.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 65.0, 56.0, 58.0, 55.0, 55.0, 55.0, 55.0, 54.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 55.0, 56.0, 55.0, 56.0, 55.0, 55.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 83.0, 84.0, 83.0, 82.0, 82.0, 86.0, 82.0, 82.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 140.0, 131.0, 129.0, 148.0, 132.0, 131.0, 135.0, 189.0, 140.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 191.0, 193.0, 190.0, 190.0, 188.0, 198.0, 186.0, 196.0, 193.0], "value": 190.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 77.0, 73.0, 75.0, 77.0, 70.0, 74.0, 73.0, 69.0], "value": 73.1, "unit": "score"}]}]} 17:18:18 INFO - Return code: 0 17:18:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:18:18 INFO - # TBPL SUCCESS # 17:18:18 INFO - Running post-action listener: _resource_record_post_action 17:18:18 INFO - [mozharness: 2017-05-06 00:18:18.916245Z] Finished run-tests step (success) 17:18:18 INFO - Running post-run listener: _resource_record_post_run 17:18:18 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 346640384; Read time: 168; Write time: 194564 17:18:18 INFO - TinderboxPrint: CPU usage
13.3% 17:18:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 168 17:18:18 INFO - TinderboxPrint: I/O write bytes / time
346,640,384 / 194,564 17:18:18 INFO - TinderboxPrint: CPU idle
8,298.2 (86.7%) 17:18:18 INFO - TinderboxPrint: CPU user
1,216.0 (12.7%) 17:18:18 INFO - TinderboxPrint: Swap in / out
0 / 0 17:18:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 30744576; Read time: 0; Write time: 6552 17:18:19 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275492864; Read time: 168; Write time: 174996 17:18:19 INFO - Running post-run listener: _upload_blobber_files 17:18:19 INFO - Blob upload gear active. 17:18:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:18:19 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 17:18:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:18:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:18:19 INFO - (blobuploader) - INFO - Open directory for files ... 17:18:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:18:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:18:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:20 INFO - (blobuploader) - INFO - Done attempting. 17:18:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:18:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:18:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:21 INFO - (blobuploader) - INFO - Done attempting. 17:18:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:18:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:18:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:24 INFO - (blobuploader) - INFO - Done attempting. 17:18:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:18:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:18:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:25 INFO - (blobuploader) - INFO - Done attempting. 17:18:25 INFO - (blobuploader) - INFO - Iteration through files over. 17:18:25 INFO - Return code: 0 17:18:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:18:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:18:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57468fe93735dc32cf0e1096a37e9da52927e89dba6d34bacd705dec745b780e5d5686d0b803c5004aac822d19922054bdf069b2ab3a29b974db3d373e1d15f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6a9c36373e9daaa60c9493d4b2f951348d8600b4190ffc685aabf082b5af37e70abe5cbdc20d45396114385031c189f32429d76cd65a3b04c682b3bb0d99d3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8906b8c9fb319b052c2fec258e295bf85629af2d0ed6c1c24045fc4e5ae1673e0a76fce1161eb092c15bdd93608c1cb8ac3966fa35679761b568c0c9fbfa727", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afd4baf4a97e8d41dc5e183467e3ee24002d1a6abf369471c8940ae66ce894dba298a551fdae5e2c6954c4debc543fed7144ccbe4decd952e2bad46e5987939e"} 17:18:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:18:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:18:25 INFO - Contents: 17:18:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57468fe93735dc32cf0e1096a37e9da52927e89dba6d34bacd705dec745b780e5d5686d0b803c5004aac822d19922054bdf069b2ab3a29b974db3d373e1d15f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6a9c36373e9daaa60c9493d4b2f951348d8600b4190ffc685aabf082b5af37e70abe5cbdc20d45396114385031c189f32429d76cd65a3b04c682b3bb0d99d3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8906b8c9fb319b052c2fec258e295bf85629af2d0ed6c1c24045fc4e5ae1673e0a76fce1161eb092c15bdd93608c1cb8ac3966fa35679761b568c0c9fbfa727", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afd4baf4a97e8d41dc5e183467e3ee24002d1a6abf369471c8940ae66ce894dba298a551fdae5e2c6954c4debc543fed7144ccbe4decd952e2bad46e5987939e"} 17:18:25 INFO - Running post-run listener: copy_logs_to_upload_dir 17:18:25 INFO - Copying logs to upload dir... 17:18:25 INFO - mkdir: /builds/slave/test/build/upload/logs 17:18:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.807781 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-05 17:18:25.617193) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 17:18:25.621829) ========= 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=41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579 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/sha512/57468fe93735dc32cf0e1096a37e9da52927e89dba6d34bacd705dec745b780e5d5686d0b803c5004aac822d19922054bdf069b2ab3a29b974db3d373e1d15f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6a9c36373e9daaa60c9493d4b2f951348d8600b4190ffc685aabf082b5af37e70abe5cbdc20d45396114385031c189f32429d76cd65a3b04c682b3bb0d99d3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8906b8c9fb319b052c2fec258e295bf85629af2d0ed6c1c24045fc4e5ae1673e0a76fce1161eb092c15bdd93608c1cb8ac3966fa35679761b568c0c9fbfa727", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afd4baf4a97e8d41dc5e183467e3ee24002d1a6abf369471c8940ae66ce894dba298a551fdae5e2c6954c4debc543fed7144ccbe4decd952e2bad46e5987939e"} build_url:https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/EWflnxvjTLGDZGMtKkQrVg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57468fe93735dc32cf0e1096a37e9da52927e89dba6d34bacd705dec745b780e5d5686d0b803c5004aac822d19922054bdf069b2ab3a29b974db3d373e1d15f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6a9c36373e9daaa60c9493d4b2f951348d8600b4190ffc685aabf082b5af37e70abe5cbdc20d45396114385031c189f32429d76cd65a3b04c682b3bb0d99d3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8906b8c9fb319b052c2fec258e295bf85629af2d0ed6c1c24045fc4e5ae1673e0a76fce1161eb092c15bdd93608c1cb8ac3966fa35679761b568c0c9fbfa727", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afd4baf4a97e8d41dc5e183467e3ee24002d1a6abf369471c8940ae66ce894dba298a551fdae5e2c6954c4debc543fed7144ccbe4decd952e2bad46e5987939e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 17:18:25.650348) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 17:18:25.650685) ========= 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=41bf3e9aed84707956354da8000001c5-1494028150.262857-460359579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004396 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 17:18:25.731053) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 17:18:25.734398) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 17:18:25.734729) ========= ========= Total master_lag: 0.19 =========