builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-086 starttime: 1494067892.62 results: success (0) revision: 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-06 03:51:32.619369) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-06 03:51:32.619811) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-06 03:51:32.620117) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-06 03:51:32.635195) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-06 03:51:32.635493) ========= 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=438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-06 03:51:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.8M=0s 2017-05-06 03:51:33 (37.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141259 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-06 03:51:32.791012) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-06 03:51:32.791344) ========= 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=438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022111 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-06 03:51:32.840785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-06 03:51:32.841259) ========= 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=438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-06 03:51:33,235 truncating revision to first 12 chars 2017-05-06 03:51:33,235 Setting DEBUG logging. 2017-05-06 03:51:33,235 attempt 1/10 2017-05-06 03:51:33,235 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-06 03:51:33,753 unpacking tar archive at: mozilla-central-37a5b7f6f101/testing/mozharness/ program finished with exit code 0 elapsedTime=0.859427 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-06 03:51:33.714827) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-06 03:51:33.715098) ========= script_repo_revision: 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-06 03:51:33.715461) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-06 03:51:33.715722) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-06 03:51:33.725354) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-05-06 03:51:33.725622) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:51:34 INFO - MultiFileLogger online at 20170506 03:51:34 in /builds/slave/test 03:51:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:51:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:51:34 INFO - {'append_to_log': False, 03:51:34 INFO - 'base_work_dir': '/builds/slave/test', 03:51:34 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:51:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:51:34 INFO - 'branch': 'Firefox-Non-PGO', 03:51:34 INFO - 'buildbot_json_path': 'buildprops.json', 03:51:34 INFO - 'config_files': ('talos/linux_config.py',), 03:51:34 INFO - 'default_actions': ('clobber', 03:51:34 INFO - 'read-buildbot-config', 03:51:34 INFO - 'download-and-extract', 03:51:34 INFO - 'populate-webroot', 03:51:34 INFO - 'create-virtualenv', 03:51:34 INFO - 'install', 03:51:34 INFO - 'run-tests'), 03:51:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:51:34 INFO - 'download_minidump_stackwalk': True, 03:51:34 INFO - 'download_symbols': 'ondemand', 03:51:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:51:34 INFO - 'tooltool.py': '/tools/tooltool.py', 03:51:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:51:34 INFO - '/tools/misc-python/virtualenv.py')}, 03:51:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:51:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:51:34 INFO - 'gecko_profile': False, 03:51:34 INFO - 'gecko_profile_interval': 0, 03:51:34 INFO - 'installer_path': 'installer.exe', 03:51:34 INFO - 'log_level': 'info', 03:51:34 INFO - 'log_name': 'talos', 03:51:34 INFO - 'log_to_console': True, 03:51:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:51:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:51:34 INFO - 'opt_config_files': (), 03:51:34 INFO - 'pip_index': False, 03:51:34 INFO - 'suite': 'dromaeojs-e10s', 03:51:34 INFO - 'system_bits': '32', 03:51:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:51:34 INFO - 'title': 'talos-linux64-ix-086', 03:51:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:51:34 INFO - 'use_talos_json': True, 03:51:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:51:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:51:34 INFO - 'work_dir': 'build'} 03:51:34 INFO - [mozharness: 2017-05-06 10:51:34.220820Z] Running clobber step. 03:51:34 INFO - Running pre-action listener: _resource_record_pre_action 03:51:34 INFO - Running main action method: clobber 03:51:34 INFO - rmtree: /builds/slave/test/build 03:51:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:51:35 INFO - Running post-action listener: _resource_record_post_action 03:51:35 INFO - [mozharness: 2017-05-06 10:51:35.682709Z] Finished clobber step (success) 03:51:35 INFO - [mozharness: 2017-05-06 10:51:35.682808Z] Running read-buildbot-config step. 03:51:35 INFO - Running pre-action listener: _resource_record_pre_action 03:51:35 INFO - Running main action method: read_buildbot_config 03:51:35 INFO - Using buildbot properties: 03:51:35 INFO - { 03:51:35 INFO - "project": "", 03:51:35 INFO - "product": "firefox", 03:51:35 INFO - "who": "nobody@mozilla.org", 03:51:35 INFO - "installer_path": "public/build/target.tar.bz2", 03:51:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:51:35 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:51:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:51:35 INFO - "stage_platform": "linux64", 03:51:35 INFO - "basedir": "/builds/slave/test", 03:51:35 INFO - "buildnumber": 856, 03:51:35 INFO - "platform": "ubuntu64_hw", 03:51:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:51:35 INFO - "slavebuilddir": "test", 03:51:35 INFO - "taskId": "CXAFhnNySdmMxDJkQJA6DQ", 03:51:35 INFO - "branch": "mozilla-central", 03:51:35 INFO - "script_repo_revision": "production", 03:51:35 INFO - "revision": "37a5b7f6f101df2eb292b1b6baaf1540c9920e20", 03:51:35 INFO - "slavename": "talos-linux64-ix-086", 03:51:35 INFO - "repo_path": "mozilla-central" 03:51:35 INFO - } 03:51:35 INFO - Finding installer, test and symbols from parent task. 03:51:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CXAFhnNySdmMxDJkQJA6DQ'}, attempt #1 03:51:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CXAFhnNySdmMxDJkQJA6DQ'}, attempt #1 03:51:36 INFO - Task dependencies: QPxxp6xHQ5a8axI1qoWtOQ 03:51:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ'}, attempt #1 03:51:37 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.tar.bz2 03:51:37 INFO - Set test_url: https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/test_packages.json 03:51:37 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.crashreporter-symbols.zip 03:51:37 INFO - Running post-action listener: _resource_record_post_action 03:51:37 INFO - [mozharness: 2017-05-06 10:51:37.038935Z] Finished read-buildbot-config step (success) 03:51:37 INFO - [mozharness: 2017-05-06 10:51:37.039155Z] Running download-and-extract step. 03:51:37 INFO - Running pre-action listener: _resource_record_pre_action 03:51:37 INFO - Running main action method: download_and_extract 03:51:37 INFO - mkdir: /builds/slave/test/build/tests 03:51:37 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')]} 03:51:37 INFO - trying https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.test_packages.json 03:51:37 INFO - Downloading https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:51:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:51:37 INFO - Downloaded 986 bytes. 03:51:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:51:37 INFO - Using the following test package requirements: 03:51:37 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:51:37 INFO - u'common': [u'target.common.tests.zip'], 03:51:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:51:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:51:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:51:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:51:37 INFO - u'mozbase': [u'target.common.tests.zip'], 03:51:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:51:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:51:37 INFO - u'web-platform': [u'target.common.tests.zip', 03:51:37 INFO - u'target.web-platform.tests.zip'], 03:51:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:51:37 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:51:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.common.tests.zip 03:51:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:51:37 INFO - Fetch https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.common.tests.zip into memory 03:51:39 INFO - Content-Length response header: 60561759 03:51:39 INFO - Bytes received: 60561759 03:51:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:51:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.common.tests.zip 03:51:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:51:49 INFO - Fetch https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.common.tests.zip into memory 03:51:50 INFO - Content-Length response header: 60561759 03:51:50 INFO - Bytes received: 60561759 03:52:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.talos.tests.zip 03:52:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:52:01 INFO - Fetch https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.talos.tests.zip into memory 03:52:02 INFO - Content-Length response header: 14408697 03:52:02 INFO - Bytes received: 14408697 03:52:02 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')]} 03:52:02 INFO - trying https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.tar.bz2 03:52:02 INFO - Downloading https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:52:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:52:03 INFO - Downloaded 64037828 bytes. 03:52:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.tar.bz2 03:52:03 INFO - mkdir: /builds/slave/test/properties 03:52:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:52:03 INFO - Writing to file /builds/slave/test/properties/build_url 03:52:03 INFO - Contents: 03:52:03 INFO - build_url:https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.tar.bz2 03:52:03 INFO - Running post-action listener: _resource_record_post_action 03:52:03 INFO - Running post-action listener: set_extra_try_arguments 03:52:03 INFO - [mozharness: 2017-05-06 10:52:03.581840Z] Finished download-and-extract step (success) 03:52:03 INFO - [mozharness: 2017-05-06 10:52:03.581937Z] Running populate-webroot step. 03:52:03 INFO - Running pre-action listener: _resource_record_pre_action 03:52:03 INFO - Running main action method: populate_webroot 03:52:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:52:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:52:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:52:03 INFO - '--tppagecycles', 03:52:03 INFO - '7'], 03:52:03 INFO - 'tests': ['tsvgm']}}, 03:52:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:52:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:52:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:52:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:52:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:52:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:52:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:52:03 INFO - 'talos_options': ['--disable-e10s'], 03:52:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:52:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:52:03 INFO - 'talos_options': ['--disable-e10s'], 03:52:03 INFO - 'tests': ['damp', 'tps']}, 03:52:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:52:03 INFO - 'tests': ['damp', 'tps']}, 03:52:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:52:03 INFO - 'tests': ['dromaeo_dom']}, 03:52:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:52:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:52:03 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:52:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:52:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:52:03 INFO - 'tests': ['a11yr', 03:52:03 INFO - 'ts_paint', 03:52:03 INFO - 'tpaint', 03:52:03 INFO - 'sessionrestore', 03:52:03 INFO - 'sessionrestore_no_auto_restore', 03:52:03 INFO - 'tabpaint']}, 03:52:03 INFO - 'other-e10s': {'tests': ['a11yr', 03:52:03 INFO - 'ts_paint', 03:52:03 INFO - 'tpaint', 03:52:03 INFO - 'sessionrestore', 03:52:03 INFO - 'sessionrestore_no_auto_restore', 03:52:03 INFO - 'tabpaint']}, 03:52:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:52:03 INFO - 'ts_paint', 03:52:03 INFO - 'tpaint', 03:52:03 INFO - 'sessionrestore', 03:52:03 INFO - 'sessionrestore_no_auto_restore', 03:52:03 INFO - 'tabpaint']}, 03:52:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:52:03 INFO - 'ts_paint', 03:52:03 INFO - 'tpaint', 03:52:03 INFO - 'sessionrestore', 03:52:03 INFO - 'sessionrestore_no_auto_restore', 03:52:03 INFO - 'tabpaint']}, 03:52:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:52:03 INFO - 'tests': ['a11yr', 03:52:03 INFO - 'ts_paint', 03:52:03 INFO - 'tpaint', 03:52:03 INFO - 'sessionrestore', 03:52:03 INFO - 'sessionrestore_no_auto_restore', 03:52:03 INFO - 'tabpaint']}, 03:52:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:52:03 INFO - 'tests': ['a11yr', 03:52:03 INFO - 'ts_paint', 03:52:03 INFO - 'tpaint', 03:52:03 INFO - 'sessionrestore', 03:52:03 INFO - 'sessionrestore_no_auto_restore', 03:52:03 INFO - 'tabpaint']}, 03:52:03 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:52:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:52:03 INFO - 'bloom_basic_ref']}, 03:52:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:52:03 INFO - 'tests': ['tsvgx', 03:52:03 INFO - 'tsvgr_opacity', 03:52:03 INFO - 'tart', 03:52:03 INFO - 'tscrollx', 03:52:03 INFO - 'cart', 03:52:03 INFO - 'tsvg_static']}, 03:52:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:52:03 INFO - 'tsvgr_opacity', 03:52:03 INFO - 'tart', 03:52:03 INFO - 'tscrollx', 03:52:03 INFO - 'cart', 03:52:03 INFO - 'tsvg_static']}, 03:52:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:52:03 INFO - 'talos_options': ['--disable-e10s'], 03:52:03 INFO - 'tests': ['tp5o']}, 03:52:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:52:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:52:03 INFO - 'talos_options': ['--disable-e10s', 03:52:03 INFO - '--xperf_path', 03:52:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:03 INFO - 'tests': ['tp5n']}, 03:52:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:52:03 INFO - 'talos_options': ['--xperf_path', 03:52:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:03 INFO - 'tests': ['tp5n']}}, 03:52:03 INFO - 'talos.zip': {'path': '', 03:52:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:52:03 INFO - Running post-action listener: _resource_record_post_action 03:52:03 INFO - [mozharness: 2017-05-06 10:52:03.595709Z] Finished populate-webroot step (success) 03:52:03 INFO - [mozharness: 2017-05-06 10:52:03.595799Z] Running create-virtualenv step. 03:52:03 INFO - Running pre-action listener: _resource_record_pre_action 03:52:03 INFO - Running main action method: create_virtualenv 03:52:03 INFO - Creating virtualenv /builds/slave/test/build/venv 03:52:03 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 03:52:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:52:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:52:03 INFO - Using real prefix '/usr' 03:52:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:52:04 INFO - Installing distribute.............................................................................................................................................................................................done. 03:52:06 INFO - Installing pip.................done. 03:52:06 INFO - Return code: 0 03:52:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:52:06 INFO - Reading from file tmpfile_stdout 03:52:06 INFO - Output received: 03:52:06 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) 03:52:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:52: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')]} 03:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52: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')]} 03:52:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1319a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14beb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bc290>, '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 0x14bcb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bd040>, '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': '438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364', '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 03:52: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', 'pip>=1.5'] in /builds/slave/test/build 03:52: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 pip>=1.5 03:52:06 INFO - Using env: {'DISPLAY': ':0', 03:52:06 INFO - 'HOME': '/home/cltbld', 03:52:06 INFO - 'LANG': 'en_US.UTF-8', 03:52:06 INFO - 'LANGUAGE': 'en_US:en', 03:52:06 INFO - 'LOGNAME': 'cltbld', 03:52:06 INFO - 'MAIL': '/var/mail/cltbld', 03:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:06 INFO - 'MOZ_NO_REMOTE': '1', 03:52:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:06 INFO - 'NO_EM_RESTART': '1', 03:52:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:06 INFO - 'PWD': '/builds/slave/test', 03:52:06 INFO - 'SHELL': '/bin/bash', 03:52:06 INFO - 'SHLVL': '1', 03:52:06 INFO - 'TERM': 'linux', 03:52:06 INFO - 'TMOUT': '86400', 03:52:06 INFO - 'USER': 'cltbld', 03:52:06 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364', 03:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:06 INFO - '_': '/tools/buildbot/bin/python'} 03:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:06 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 03:52:06 INFO - Cleaning up... 03:52:06 INFO - Return code: 0 03:52:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:52: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')]} 03:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52: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')]} 03:52:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52: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', '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 0x12211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1319a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14beb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bc290>, '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 0x14bcb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bd040>, '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': '438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364', '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 03:52: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:52: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 psutil>=3.1.1 03:52:06 INFO - Using env: {'DISPLAY': ':0', 03:52:06 INFO - 'HOME': '/home/cltbld', 03:52:06 INFO - 'LANG': 'en_US.UTF-8', 03:52:06 INFO - 'LANGUAGE': 'en_US:en', 03:52:06 INFO - 'LOGNAME': 'cltbld', 03:52:06 INFO - 'MAIL': '/var/mail/cltbld', 03:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:06 INFO - 'MOZ_NO_REMOTE': '1', 03:52:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:06 INFO - 'NO_EM_RESTART': '1', 03:52:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:06 INFO - 'PWD': '/builds/slave/test', 03:52:06 INFO - 'SHELL': '/bin/bash', 03:52:06 INFO - 'SHLVL': '1', 03:52:06 INFO - 'TERM': 'linux', 03:52:06 INFO - 'TMOUT': '86400', 03:52:06 INFO - 'USER': 'cltbld', 03:52:06 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364', 03:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:06 INFO - '_': '/tools/buildbot/bin/python'} 03:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:06 INFO - Downloading/unpacking psutil>=3.1.1 03:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:52:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:08 INFO - Installing collected packages: psutil 03:52:08 INFO - Running setup.py install for psutil 03:52:08 INFO - building 'psutil._psutil_linux' extension 03:52:08 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 03:52:08 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 03:52:08 INFO - building 'psutil._psutil_posix' extension 03:52:08 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 03:52:08 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 03:52:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:08 INFO - Successfully installed psutil 03:52:08 INFO - Cleaning up... 03:52:08 INFO - Return code: 0 03:52:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:52: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')]} 03:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52: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')]} 03:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1319a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14beb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bc290>, '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 0x14bcb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bd040>, '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': '438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364', '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 03:52: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:52: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 mozsystemmonitor==0.3 03:52:08 INFO - Using env: {'DISPLAY': ':0', 03:52:08 INFO - 'HOME': '/home/cltbld', 03:52:08 INFO - 'LANG': 'en_US.UTF-8', 03:52:08 INFO - 'LANGUAGE': 'en_US:en', 03:52:08 INFO - 'LOGNAME': 'cltbld', 03:52:08 INFO - 'MAIL': '/var/mail/cltbld', 03:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:08 INFO - 'MOZ_NO_REMOTE': '1', 03:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:08 INFO - 'NO_EM_RESTART': '1', 03:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:08 INFO - 'PWD': '/builds/slave/test', 03:52:08 INFO - 'SHELL': '/bin/bash', 03:52:08 INFO - 'SHLVL': '1', 03:52:08 INFO - 'TERM': 'linux', 03:52:08 INFO - 'TMOUT': '86400', 03:52:08 INFO - 'USER': 'cltbld', 03:52:08 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364', 03:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:08 INFO - '_': '/tools/buildbot/bin/python'} 03:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:52: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 03:52: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 03:52: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 03:52: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 03:52: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 03:52: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 03:52:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:52:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:52:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:52:09 INFO - Installing collected packages: mozsystemmonitor 03:52:09 INFO - Running setup.py install for mozsystemmonitor 03:52:09 INFO - Successfully installed mozsystemmonitor 03:52:09 INFO - Cleaning up... 03:52:10 INFO - Return code: 0 03:52:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:52: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')]} 03:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52: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')]} 03:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52: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', '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 0x12211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1319a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14beb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bc290>, '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 0x14bcb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bd040>, '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': '438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364', '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 03:52: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:52: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 jsonschema==2.5.1 03:52:10 INFO - Using env: {'DISPLAY': ':0', 03:52:10 INFO - 'HOME': '/home/cltbld', 03:52:10 INFO - 'LANG': 'en_US.UTF-8', 03:52:10 INFO - 'LANGUAGE': 'en_US:en', 03:52:10 INFO - 'LOGNAME': 'cltbld', 03:52:10 INFO - 'MAIL': '/var/mail/cltbld', 03:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:10 INFO - 'MOZ_NO_REMOTE': '1', 03:52:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:10 INFO - 'NO_EM_RESTART': '1', 03:52:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:10 INFO - 'PWD': '/builds/slave/test', 03:52:10 INFO - 'SHELL': '/bin/bash', 03:52:10 INFO - 'SHLVL': '1', 03:52:10 INFO - 'TERM': 'linux', 03:52:10 INFO - 'TMOUT': '86400', 03:52:10 INFO - 'USER': 'cltbld', 03:52:10 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364', 03:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:10 INFO - '_': '/tools/buildbot/bin/python'} 03:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:10 INFO - Downloading/unpacking jsonschema==2.5.1 03:52: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 03:52: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 03:52: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 03:52: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 03:52: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 03:52: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 03:52:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:52:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:52: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 03:52: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 03:52: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 03:52: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 03:52: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 03:52: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 03:52:11 INFO - Downloading functools32-3.2.3-2.tar.gz 03:52:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:52:11 INFO - warning: no files found matching '*.txt' 03:52:11 INFO - no previously-included directories found matching 'build' 03:52:11 INFO - no previously-included directories found matching 'dist' 03:52:11 INFO - no previously-included directories found matching '.git*' 03:52:11 INFO - Installing collected packages: jsonschema, functools32 03:52:11 INFO - Running setup.py install for functools32 03:52:11 INFO - warning: no files found matching '*.txt' 03:52:11 INFO - no previously-included directories found matching 'build' 03:52:11 INFO - no previously-included directories found matching 'dist' 03:52:11 INFO - no previously-included directories found matching '.git*' 03:52:11 INFO - Successfully installed jsonschema functools32 03:52:11 INFO - Cleaning up... 03:52:11 INFO - Return code: 0 03:52:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:52:11 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')]} 03:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:11 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')]} 03:52:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:11 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 0x12211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1319a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14beb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bc290>, '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 0x14bcb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bd040>, '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': '438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364', '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 03:52:11 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 03:52:11 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 03:52:11 INFO - Using env: {'DISPLAY': ':0', 03:52:11 INFO - 'HOME': '/home/cltbld', 03:52:11 INFO - 'LANG': 'en_US.UTF-8', 03:52:11 INFO - 'LANGUAGE': 'en_US:en', 03:52:11 INFO - 'LOGNAME': 'cltbld', 03:52:11 INFO - 'MAIL': '/var/mail/cltbld', 03:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:11 INFO - 'MOZ_NO_REMOTE': '1', 03:52:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:11 INFO - 'NO_EM_RESTART': '1', 03:52:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:11 INFO - 'PWD': '/builds/slave/test', 03:52:11 INFO - 'SHELL': '/bin/bash', 03:52:11 INFO - 'SHLVL': '1', 03:52:11 INFO - 'TERM': 'linux', 03:52:11 INFO - 'TMOUT': '86400', 03:52:11 INFO - 'USER': 'cltbld', 03:52:11 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364', 03:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:11 INFO - '_': '/tools/buildbot/bin/python'} 03:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:52:11 INFO - Cleaning up... 03:52:11 INFO - Return code: 0 03:52:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:52:11 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')]} 03:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:11 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')]} 03:52:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:11 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 0x12211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1319a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14beb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bc290>, '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 0x14bcb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bd040>, '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': '438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364', '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 03:52:11 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 03:52:11 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 03:52:11 INFO - Using env: {'DISPLAY': ':0', 03:52:11 INFO - 'HOME': '/home/cltbld', 03:52:11 INFO - 'LANG': 'en_US.UTF-8', 03:52:11 INFO - 'LANGUAGE': 'en_US:en', 03:52:11 INFO - 'LOGNAME': 'cltbld', 03:52:11 INFO - 'MAIL': '/var/mail/cltbld', 03:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:11 INFO - 'MOZ_NO_REMOTE': '1', 03:52:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:11 INFO - 'NO_EM_RESTART': '1', 03:52:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:11 INFO - 'PWD': '/builds/slave/test', 03:52:11 INFO - 'SHELL': '/bin/bash', 03:52:11 INFO - 'SHLVL': '1', 03:52:11 INFO - 'TERM': 'linux', 03:52:11 INFO - 'TMOUT': '86400', 03:52:11 INFO - 'USER': 'cltbld', 03:52:11 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364', 03:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:11 INFO - '_': '/tools/buildbot/bin/python'} 03:52:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:12 INFO - Downloading/unpacking blobuploader==1.2.4 03:52: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 03:52: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 03:52: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 03:52: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 03:52: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 03:52: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 03:52:13 INFO - Downloading blobuploader-1.2.4.tar.gz 03:52:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:52:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:52:13 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 03:52:13 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 03:52:13 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 03:52:13 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 03:52:13 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 03:52:13 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 03:52:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:52:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:52:13 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 03:52:13 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 03:52:13 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 03:52:13 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 03:52:13 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 03:52:13 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 03:52:13 INFO - Downloading docopt-0.6.1.tar.gz 03:52:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:52:13 INFO - Installing collected packages: blobuploader, requests, docopt 03:52:13 INFO - Running setup.py install for blobuploader 03:52:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:52:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:52:13 INFO - Running setup.py install for requests 03:52:14 INFO - Running setup.py install for docopt 03:52:14 INFO - Successfully installed blobuploader requests docopt 03:52:14 INFO - Cleaning up... 03:52:14 INFO - Return code: 0 03:52:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:14 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 0x12211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1319a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14beb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bc290>, '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 0x14bcb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bd040>, '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': '438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364', '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 03:52:14 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 03:52:14 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 03:52:14 INFO - Using env: {'DISPLAY': ':0', 03:52:14 INFO - 'HOME': '/home/cltbld', 03:52:14 INFO - 'LANG': 'en_US.UTF-8', 03:52:14 INFO - 'LANGUAGE': 'en_US:en', 03:52:14 INFO - 'LOGNAME': 'cltbld', 03:52:14 INFO - 'MAIL': '/var/mail/cltbld', 03:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:14 INFO - 'MOZ_NO_REMOTE': '1', 03:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:14 INFO - 'NO_EM_RESTART': '1', 03:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:14 INFO - 'PWD': '/builds/slave/test', 03:52:14 INFO - 'SHELL': '/bin/bash', 03:52:14 INFO - 'SHLVL': '1', 03:52:14 INFO - 'TERM': 'linux', 03:52:14 INFO - 'TMOUT': '86400', 03:52:14 INFO - 'USER': 'cltbld', 03:52:14 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364', 03:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:14 INFO - '_': '/tools/buildbot/bin/python'} 03:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:14 INFO - Running setup.py (path:/tmp/pip-pWD2Zv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:14 INFO - Running setup.py (path:/tmp/pip-a8IzcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:14 INFO - Running setup.py (path:/tmp/pip-9nvfwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:14 INFO - Running setup.py (path:/tmp/pip-CfwY3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:14 INFO - Running setup.py (path:/tmp/pip-lElyJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:14 INFO - Running setup.py (path:/tmp/pip-Jbqo7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:15 INFO - Running setup.py (path:/tmp/pip-SVBdqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:15 INFO - Running setup.py (path:/tmp/pip-wnzNvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:15 INFO - Running setup.py (path:/tmp/pip-P5O2Kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:15 INFO - Running setup.py (path:/tmp/pip-4VtpNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:15 INFO - Running setup.py (path:/tmp/pip-BSVTsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:15 INFO - Running setup.py (path:/tmp/pip-tax_aX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:15 INFO - Running setup.py (path:/tmp/pip-I32K_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:15 INFO - Running setup.py (path:/tmp/pip-nXmQv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:15 INFO - Running setup.py (path:/tmp/pip-1VkyHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:15 INFO - Running setup.py (path:/tmp/pip-Dvwu5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:15 INFO - Running setup.py (path:/tmp/pip-7APxlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:52:15 INFO - Running setup.py install for manifestparser 03:52:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:52:15 INFO - Running setup.py install for mozcrash 03:52:16 INFO - Running setup.py install for mozdebug 03:52:16 INFO - Running setup.py install for mozdevice 03:52:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:52:16 INFO - Running setup.py install for mozfile 03:52:16 INFO - Running setup.py install for mozhttpd 03:52:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:52:16 INFO - Running setup.py install for mozinfo 03:52:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:52:16 INFO - Running setup.py install for mozInstall 03:52:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:52:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:52:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:52:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:52:16 INFO - Running setup.py install for mozleak 03:52:16 INFO - Running setup.py install for mozlog 03:52:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:52:16 INFO - Running setup.py install for moznetwork 03:52:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:52:16 INFO - Running setup.py install for mozprocess 03:52:17 INFO - Running setup.py install for mozprofile 03:52:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:52:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:52:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:52:17 INFO - Running setup.py install for mozrunner 03:52:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:52:17 INFO - Running setup.py install for mozscreenshot 03:52:17 INFO - Running setup.py install for moztest 03:52:17 INFO - Running setup.py install for mozversion 03:52:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:52:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:52:17 INFO - Cleaning up... 03:52:17 INFO - Return code: 0 03:52:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:17 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')]} 03:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:17 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')]} 03:52:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:17 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 0x12211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1319a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14beb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bc290>, '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 0x14bcb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bd040>, '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': '438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364', '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 03:52:17 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 03:52:17 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 03:52:17 INFO - Using env: {'DISPLAY': ':0', 03:52:17 INFO - 'HOME': '/home/cltbld', 03:52:17 INFO - 'LANG': 'en_US.UTF-8', 03:52:17 INFO - 'LANGUAGE': 'en_US:en', 03:52:17 INFO - 'LOGNAME': 'cltbld', 03:52:17 INFO - 'MAIL': '/var/mail/cltbld', 03:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:17 INFO - 'MOZ_NO_REMOTE': '1', 03:52:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:17 INFO - 'NO_EM_RESTART': '1', 03:52:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:17 INFO - 'PWD': '/builds/slave/test', 03:52:17 INFO - 'SHELL': '/bin/bash', 03:52:17 INFO - 'SHLVL': '1', 03:52:17 INFO - 'TERM': 'linux', 03:52:17 INFO - 'TMOUT': '86400', 03:52:17 INFO - 'USER': 'cltbld', 03:52:17 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364', 03:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:17 INFO - '_': '/tools/buildbot/bin/python'} 03:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:17 INFO - Running setup.py (path:/tmp/pip-BDcvna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:17 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)) 03:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:17 INFO - Running setup.py (path:/tmp/pip-yJakrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:18 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)) 03:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:18 INFO - Running setup.py (path:/tmp/pip-9IkfkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:18 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)) 03:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:18 INFO - Running setup.py (path:/tmp/pip-1xV56t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:18 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)) 03:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:18 INFO - Running setup.py (path:/tmp/pip-q5AYb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:18 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)) 03:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:18 INFO - Running setup.py (path:/tmp/pip-1I1HDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:18 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)) 03:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:18 INFO - Running setup.py (path:/tmp/pip-sH5B6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:18 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)) 03:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:18 INFO - Running setup.py (path:/tmp/pip-L9dlQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:18 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)) 03:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:18 INFO - Running setup.py (path:/tmp/pip-y0rKUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:18 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)) 03:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:18 INFO - Running setup.py (path:/tmp/pip-9iI1_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:18 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)) 03:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:18 INFO - Running setup.py (path:/tmp/pip-Su3dyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:18 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)) 03:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:18 INFO - Running setup.py (path:/tmp/pip-t8pTxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:18 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)) 03:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:18 INFO - Running setup.py (path:/tmp/pip-SlQH33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:18 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)) 03:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:18 INFO - Running setup.py (path:/tmp/pip-tW7m3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:18 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)) 03:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:18 INFO - Running setup.py (path:/tmp/pip-FKwCZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:18 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)) 03:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:18 INFO - Running setup.py (path:/tmp/pip-u8p7ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:19 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)) 03:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:19 INFO - Running setup.py (path:/tmp/pip-bxQUgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:19 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)) 03:52:19 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)) 03:52:19 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)) 03:52:19 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)) 03:52:19 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)) 03:52:19 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)) 03:52:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:20 INFO - Downloading blessings-1.6.tar.gz 03:52:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:52:20 INFO - Installing collected packages: blessings 03:52:20 INFO - Running setup.py install for blessings 03:52:20 INFO - Successfully installed blessings 03:52:20 INFO - Cleaning up... 03:52:20 INFO - Return code: 0 03:52:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:52:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:52:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:52:20 INFO - Reading from file tmpfile_stdout 03:52:20 INFO - Current package versions: 03:52:20 INFO - argparse == 1.2.1 03:52:20 INFO - blessings == 1.6 03:52:20 INFO - blobuploader == 1.2.4 03:52:20 INFO - docopt == 0.6.1 03:52:20 INFO - functools32 == 3.2.3-2 03:52:20 INFO - jsonschema == 2.5.1 03:52:20 INFO - manifestparser == 1.1 03:52:20 INFO - mozInstall == 1.12 03:52:20 INFO - mozcrash == 1.0 03:52:20 INFO - mozdebug == 0.1 03:52:20 INFO - mozdevice == 0.50 03:52:20 INFO - mozfile == 1.2 03:52:20 INFO - mozhttpd == 0.7 03:52:20 INFO - mozinfo == 0.9 03:52:20 INFO - mozleak == 0.1 03:52:20 INFO - mozlog == 3.4 03:52:20 INFO - moznetwork == 0.27 03:52:20 INFO - mozprocess == 0.25 03:52:20 INFO - mozprofile == 0.28 03:52:20 INFO - mozrunner == 6.13 03:52:20 INFO - mozscreenshot == 0.1 03:52:20 INFO - mozsystemmonitor == 0.3 03:52:20 INFO - moztest == 0.8 03:52:20 INFO - mozversion == 1.4 03:52:20 INFO - psutil == 3.1.1 03:52:20 INFO - requests == 1.2.3 03:52:20 INFO - wsgiref == 0.1.2 03:52:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:20 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 0x12211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1319a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14beb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bc290>, '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 0x14bcb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bd040>, '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': '438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364', '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 03:52:20 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 03:52:20 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 03:52:20 INFO - Using env: {'DISPLAY': ':0', 03:52:20 INFO - 'HOME': '/home/cltbld', 03:52:20 INFO - 'LANG': 'en_US.UTF-8', 03:52:20 INFO - 'LANGUAGE': 'en_US:en', 03:52:20 INFO - 'LOGNAME': 'cltbld', 03:52:20 INFO - 'MAIL': '/var/mail/cltbld', 03:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:20 INFO - 'MOZ_NO_REMOTE': '1', 03:52:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:20 INFO - 'NO_EM_RESTART': '1', 03:52:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:20 INFO - 'PWD': '/builds/slave/test', 03:52:20 INFO - 'SHELL': '/bin/bash', 03:52:20 INFO - 'SHLVL': '1', 03:52:20 INFO - 'TERM': 'linux', 03:52:20 INFO - 'TMOUT': '86400', 03:52:20 INFO - 'USER': 'cltbld', 03:52:20 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364', 03:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:20 INFO - '_': '/tools/buildbot/bin/python'} 03:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:20 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)) 03:52:20 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)) 03:52:20 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)) 03:52:20 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)) 03:52:20 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)) 03:52:20 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)) 03:52:20 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)) 03:52:20 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)) 03:52:20 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)) 03:52:20 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)) 03:52:20 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)) 03:52:20 INFO - Cleaning up... 03:52:20 INFO - Return code: 0 03:52:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1319a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14beb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bc290>, '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 0x14bcb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bd040>, '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': '438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364', '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 03:52:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:52:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:52:20 INFO - Using env: {'DISPLAY': ':0', 03:52:20 INFO - 'HOME': '/home/cltbld', 03:52:20 INFO - 'LANG': 'en_US.UTF-8', 03:52:20 INFO - 'LANGUAGE': 'en_US:en', 03:52:20 INFO - 'LOGNAME': 'cltbld', 03:52:20 INFO - 'MAIL': '/var/mail/cltbld', 03:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:20 INFO - 'MOZ_NO_REMOTE': '1', 03:52:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:20 INFO - 'NO_EM_RESTART': '1', 03:52:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:20 INFO - 'PWD': '/builds/slave/test', 03:52:20 INFO - 'SHELL': '/bin/bash', 03:52:20 INFO - 'SHLVL': '1', 03:52:20 INFO - 'TERM': 'linux', 03:52:20 INFO - 'TMOUT': '86400', 03:52:20 INFO - 'USER': 'cltbld', 03:52:20 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364', 03:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:20 INFO - '_': '/tools/buildbot/bin/python'} 03:52:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:52:21 INFO - Cleaning up... 03:52:21 INFO - Return code: 0 03:52:21 INFO - Running post-action listener: _resource_record_post_action 03:52:21 INFO - Running post-action listener: _start_resource_monitoring 03:52:21 INFO - Starting resource monitoring. 03:52:21 INFO - [mozharness: 2017-05-06 10:52:21.096138Z] Finished create-virtualenv step (success) 03:52:21 INFO - [mozharness: 2017-05-06 10:52:21.096659Z] Running install step. 03:52:21 INFO - Running pre-action listener: _resource_record_pre_action 03:52:21 INFO - Running main action method: install 03:52:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:52:21 INFO - Reading from file tmpfile_stdout 03:52:21 INFO - Detecting whether we're running mozinstall >=1.0... 03:52:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:52:21 INFO - Reading from file tmpfile_stdout 03:52:21 INFO - Output received: 03:52:21 INFO - Usage: mozinstall [options] installer 03:52:21 INFO - Options: 03:52:21 INFO - -h, --help show this help message and exit 03:52:21 INFO - -d DEST, --destination=DEST 03:52:21 INFO - Directory to install application into. [default: 03:52:21 INFO - "/builds/slave/test"] 03:52:21 INFO - --app=APP Application being installed. [default: firefox] 03:52:21 INFO - mkdir: /builds/slave/test/build/application 03:52:21 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'] 03:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:52:37 INFO - Reading from file tmpfile_stdout 03:52:37 INFO - Output received: 03:52:37 INFO - /builds/slave/test/build/application/firefox/firefox 03:52:37 INFO - Running post-action listener: _resource_record_post_action 03:52:37 INFO - [mozharness: 2017-05-06 10:52:37.574412Z] Finished install step (success) 03:52:37 INFO - [mozharness: 2017-05-06 10:52:37.574658Z] Running run-tests step. 03:52:37 INFO - Running pre-action listener: _resource_record_pre_action 03:52:37 INFO - Running main action method: run_tests 03:52:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:52:37 INFO - Python 2.7.3 03:52:37 INFO - Return code: 0 03:52:37 INFO - grabbing minidump binary from tooltool 03:52:37 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')]} 03:52:37 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 0x14bc290>, '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 0x14bcb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bd040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:52:37 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 03:52:37 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 03:52:37 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 03:52:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:52:37 INFO - Return code: 0 03:52:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:52:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:52:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:52:37 INFO - ENV: RUST_BACKTRACE is now 1 03:52:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:52:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:52:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--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 03:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-086 --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 03:52:37 INFO - Using env: {'DISPLAY': ':0', 03:52:37 INFO - 'HOME': '/home/cltbld', 03:52:37 INFO - 'LANG': 'en_US.UTF-8', 03:52:37 INFO - 'LANGUAGE': 'en_US:en', 03:52:37 INFO - 'LOGNAME': 'cltbld', 03:52:37 INFO - 'MAIL': '/var/mail/cltbld', 03:52:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:52:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:37 INFO - 'MOZ_NO_REMOTE': '1', 03:52:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:52:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:37 INFO - 'NO_EM_RESTART': '1', 03:52:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:37 INFO - 'PWD': '/builds/slave/test', 03:52:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:52:37 INFO - 'RUST_BACKTRACE': '1', 03:52:37 INFO - 'SHELL': '/bin/bash', 03:52:37 INFO - 'SHLVL': '1', 03:52:37 INFO - 'TERM': 'linux', 03:52:37 INFO - 'TMOUT': '86400', 03:52:37 INFO - 'USER': 'cltbld', 03:52:37 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364', 03:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:37 INFO - '_': '/tools/buildbot/bin/python'} 03:52:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--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 03:52:37 INFO - mozversion application_buildid: 20170506100311 03:52:37 INFO - mozversion application_changeset: 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 03:52:37 INFO - mozversion application_display_name: Nightly 03:52:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:52:37 INFO - mozversion application_name: Firefox 03:52:37 INFO - mozversion application_remotingname: firefox 03:52:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:52:37 INFO - mozversion application_vendor: Mozilla 03:52:37 INFO - mozversion application_version: 55.0a1 03:52:37 INFO - mozversion platform_buildid: 20170506100311 03:52:37 INFO - mozversion platform_changeset: 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 03:52:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:52:37 INFO - mozversion platform_version: 55.0a1 03:52:37 INFO - using testdate: 1494067957 03:52:37 INFO - actual date: 1494067957 03:52:37 INFO - starting webserver on 'localhost:57902' 03:52:37 INFO - SUITE-START | Running 2 tests 03:52:37 INFO - TEST-START | dromaeo_css 03:52:37 INFO - operating with platform_type : linux_ 03:52:37 INFO - Initialising browser for dromaeo_css test... 03:52:37 INFO - TEST-INFO | started process 9103 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_shzWg/profile http://localhost:57902/getInfo.html) 03:52:41 INFO - PID 9103 | __metrics Screen width/height:1600/1200 03:52:41 INFO - PID 9103 | colorDepth:24 03:52:41 INFO - PID 9103 | Browser inner width/height: 1024/695 03:52:41 INFO - PID 9103 | __metrics 03:52:43 INFO - TEST-INFO | 9103: exit 0 03:52:43 INFO - Browser initialized. 03:52:43 INFO - Running cycle 1/1 for dromaeo_css test... 03:52:43 INFO - TEST-INFO | started process 9278 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_shzWg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:52:55 INFO - PID 9278 | RSS: Main: 156164096 03:52:55 INFO - PID 9278 | 03:55:56 INFO - PID 9278 | Cycle 1(1): loaded http://localhost:57902/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57902/tests/dromaeo/cssquery-ext.html) 03:55:58 INFO - PID 9278 | RSS: Main: 161214464 03:55:58 INFO - PID 9278 | 03:59:00 INFO - PID 9278 | Cycle 1(1): loaded http://localhost:57902/tests/dromaeo/cssquery-ext.html (next: http://localhost:57902/tests/dromaeo/cssquery-jquery.html) 03:59:00 INFO - PID 9278 | RSS: Main: 156536832 03:59:00 INFO - PID 9278 | 04:02:02 INFO - PID 9278 | Cycle 1(1): loaded http://localhost:57902/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57902/tests/dromaeo/cssquery-mootools.html) 04:02:03 INFO - PID 9278 | RSS: Main: 164016128 04:02:03 INFO - PID 9278 | 04:05:04 INFO - PID 9278 | Cycle 1(1): loaded http://localhost:57902/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57902/tests/dromaeo/cssquery-prototype.html) 04:05:05 INFO - PID 9278 | RSS: Main: 156893184 04:05:05 INFO - PID 9278 | 04:08:07 INFO - PID 9278 | Cycle 1(1): loaded http://localhost:57902/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57902/tests/dromaeo/cssquery-yui.html) 04:08:08 INFO - PID 9278 | RSS: Main: 161361920 04:08:08 INFO - PID 9278 | 04:11:09 INFO - PID 9278 | Cycle 1(1): loaded http://localhost:57902/tests/dromaeo/cssquery-yui.html (next: http://localhost:57902/tests/dromaeo/cssquery-dojo.html) 04:11:10 INFO - PID 9278 | RSS: Main: 162062336 04:11:10 INFO - PID 9278 | 04:11:10 INFO - PID 9278 | __start_tp_report 04:11:10 INFO - PID 9278 | _x_x_mozilla_page_load 04:11:10 INFO - PID 9278 | _x_x_mozilla_page_load_details 04:11:10 INFO - PID 9278 | |i|pagename|runs| 04:11:10 INFO - PID 9278 | |0;dojo.html;3349.9665003349974;3369.4440417331143;3377.0375442998743;3390.745694072942;3396.4565669492886;5859.501942334901;5878.23582934219;5880.2649668791455;5914.497267732238;5919.615225010371;5919.141724449953;5936.703164841762;5974.970125149379;5997.580169388145;6015.488683461911;4921.732799417547;5260.342457192851;5290.074237008527;5303.15149576067;5327.121025030885;5345.572354211673;5380.192971054354;5384.542313903304;5401.540869026137;5407.080796264625;5197.7920883164625;5221.425643179247;5263.105272103751;5276.445973172838;5318.760655770499;5314.096603577401;5319.7340132993195;5364.463553644643;5364.704941228231;5388;5249.055170069386;5269.552088072518;5313.335833020872;5316.3620365556;5317.9202311965355;5842.941570584282;5966.0454327307425;5972.343042265347;5985.551083668743;5988;6329.810105696836;6367.8408039798915;6459.903101453482;6470.611763294218;6499.155109835739;6492.448141907944;6519.087327774116;6529.771457998995;6531.510136739764;6548.476121910284;5980.700964951735;5992.310884248323;6070.3929607038945;6075.301340345873;6080.695965201722;6423.068655044993;6484.837879053061;6513.218413790375;6568.408843204134;6611.801645950629;6195.349488303754;6211.254649442006;6270.341614130451;6365.777197798147;6438.098666186644;6364.872702545923;6470.967645161744;6478;6490.675466226764;6504.739810407531;6472.352764723584;6480.611163330121;6481.578697384655;6494.772682956168;6496.285408605049;6264.968675156595;6343.746250149942;6354.777582784581;6361.077643741724;6485.935140648628;4991.925121123186;4997.725125118153;4998.9500104999215;5008.098542262428;5021.07110184617;4367.694261401672;4372.125574884972;4374.956250437519;4378.2119218540965;4415.227335216325;6151.938480615226;6160.599561028519;6173.074038894202;6185.628862268279;6200.906986395207;6268.843278918063;6358.33237510064;6414.037894315797;6415;6507.479401647857;6163.84590385244;6184.165137706442;6191.4118158774845;6192.535559833031;6204.534659900525;5682.460166284196;5688.744006519716;5699.145128230799;5703.600747947687;5724.513416359573;6523.934760652428;6690;6693.698783554752;6764.864702706017;6834.214065382345;6502.317256687979;6513.674316284072;6525.184351956005;6556.770513032021;6559.27847936717;6845.828854278683;6853.246142924374;6867.313268673092;6867.587944723333;6886.793396198122;6240.157578726996;6274.905876411949;6314.336994615683;6393.29673735898;6443.806685799434;6511.73953041873;6522.5760325578685;6528.934710652833;6555.508336874849;6558.967205163944;6245.588220673553;6270.686465676789;6338.271098823509;6341.112244285896;6359.745610175726;6168.383161683975;6229.127922091002;6275.717592708431;6360.014197799349;6362.331955144643;6258.530610204162;6351.904721429275;6355.936440635534;6372.74509019634;6378.840528986812;6412.839679008062;6421.550491465552;6425.614463132227;6436.517261205335;6438;5992.221011268507;6010.308814486215;6044.24446944132;6045.304789949212;6217.751289948352 04:11:10 INFO - PID 9278 | |1;ext.html;717.6268340462959;773.8529679360921;784.7292684024012;1108.512254607972;1110.8278216876377;34705.479417808754;34925.82537087311;35033.649663503355;35159;35170;36537.45193822088;36717;36772.632273677256;36976.81511592445;37124;6863.7597684081065;7016.298370162994;7075.540089894166;7178.461615378841;7198;7034.6482675866255;7073.858522829541;7079.575225486462;7104.040954471157;7172.426205903515;7106.040684507603;7162.8209294767785;7175.174854891676;7183.245759195288;7205.423566114699;7070.2576229495935;7082.681279342442;7093.929060709378;7149.53528020677;7167.89248161278;7002.75490357835;7051.083359163327;7084.752033678848;7090.220075791659;7110.32451917067;35107.82446087779;35170.47244291338;35380.29239415223;35432;35564;3431.5367425397503;3449.741269404805;3468.670476304747;3470.583529976394;3474.774139680913;27519.31201719973;27564.586531201847;27600;27644.447111057667;27650.723492765017;3632.4732913727626;3684.889453316405;3694.224212915291;3701.796401197933;3747.9063023424633;185660;185667;204625;208619.95690021606;209424;44728.10543789106;44842;44865.32702009472;45054.77472612616;45117.54882451199;46099.76950115295;46124.30813537799;46196.07607847824;46540.53459465362;46644.300335495;14471.421143154366;14480;14488.927555362156;14498.710025799635;14505.854941450661;11732.413379331;11893.345865977455;11907.226030308002;11911.404429778477;11938.22401543897;13432.395542200624;13455.663608409672;13604.251766152758;13631;13765.105268157538;5560.610757247035;5626.690532020778;5701.116326969326;5808.30300363959;5828.358880523139;1045.38844775807;1091.8034753744244;1092.088106431123;1096.4736926275432;1097.1661537231762;24363.39091522726;24581.754182457946;24654.630180547305;24817.379565510644;25278;1179.4515550268995;1182.0543565148018;1182.6511179202157;1188.9346085965183;1215.1311812054423;12972.545960891512;13129.080964332596;13164.210147391188;17660.293588256325;17675.20461579232;247569;250458;250728;250854;252423;54652.18021729677;54851.17723234155;55265.44734552683;55476.16785748217;55615.72192139013;1506.6308754355252;1521.4826958834271;1561.5705680937833;1562.093985488414;1564.5932057665088;28708.569371459027;30250.69749302567;30257;30772.53841192339;31285.374292514476;37904.24191516209;38143.42784858285;38149.046273842265;38445.807770960964;38473;213612;214534;214881;215757;216224;33494.49758253579;34456.65543344535;34539;34795.82602086973;34988.30023399467;40648.187036259704;41090;41744.79127604343;41867.58132418759;42248.155036898475;31704.841475793397;32032.5195122078;32431.837840810644;32824.671753282164;33105.33789324248;31771.205719856265;32620.673793261765;32887.50668739923;33367.66632333743;33384.666153338156;35940.64059359478;35996.28007439889;36648.26703465969;36906.077348066516;37059.25881482409;31069.68930310668;31483.370332593677;31859.20351991219;31957;32037.35925281528;23853.403664908517;25870.482590348463;26017.219483415527;26286;26329.07848225303 04:11:10 INFO - PID 9278 | |2;jquery.html;435.8975640724431;446.09442831052974;450.95715906988823;462.1611774629048;471.50962998481583;19621.50946226343;20359.898200508997;20703;20913.16347346108;21039.579208415824;21465.356039318805;21982.780172198272;22583.54832903341;22596.66105008426;23152.76847231527;5447.210154527581;5588.776448942038;5626.352969408509;5627.184058311543;5646.124850648156;5249.580033597303;5463.808766693167;5467.043267428204;5479.506844384005;5501.092319767234;5434.402215756264;5438.238646589481;5470.617056806025;5476.452354764531;5484.808031718891;5411.053065713504;5413.106837371829;5419.891602167974;5422.457754224585;5471.671699698031;4851.539103785135;4857.34425852509;4886.60907127429;4891.241857512091;4904.092742842586;24872.005119795187;25234.873825630937;25344.36639084019;25551.361215969562;25688.357791055187;2119.671450925109;2157.3959291398432;2165.1339464214284;2166.9349919502442;2167.0681606909025;17062.317507299693;17308.82691173085;17540.473785786446;17615.29538818446;17794.55513612157;2113.2392338758036;2200.3179014505554;2217.7782221777857;2228.331500549845;2236.8322375821876;106045;117061;121370;122702;122898;12432.191907525981;12480.251184928933;12634.936825316;12739.55411560591;12848.852031252403;17589.20848561818;17612.29550817953;17671.911640441973;17699;17701.55746106332;9267.907320926704;9269.073092690813;9297.67458138962;9384.812303754023;9458.196053335543;8525.31797456202;8541.188587084342;8545.529995850287;8776.385653004356;8820.779480513038;7960.124386317616;8035.55804430762;8144.837103257902;8187.795305117301;8196.42625016243;2207.75714671386;2235.742889567688;2264.2904607021924;2277.658351247326;2409.8433601815827;1011.4285428732743;1059.8728152621734;1073.0664322039875;1074.0441007503327;1075.7848430313968;18881.811181888006;20151.496212594804;20372;20387.4903127423;20610.587788244153;1076.5586109694987;1081.8377243413552;1082.6373164989816;1087.7661302819931;1089.5260561655705;10950.945245273882;11435.428228588704;11456;11477.311361318347;11541.249818761753;425608;429105;450231;454572;454725;92001.53999229961;94080;94454.52772736092;95205.52397238108;95238;1176.335370515656;1219.9634010979685;1233.975320493585;1245.2404033539533;1263.7788387032233;16685.833141668427;17087.31650733957;17481.650366992333;17769.644607108043;18103;44612;44619.77690111659;44813.32780008368;45491.772541137085;45734.771326143156;54042.459575403744;54303;54503.18245226404;55076.449235507134;55728;9420.905790942003;9605.903940960781;9643.421394716339;9675.274354423305;9761.804763904824;14792.778108328599;15148.924255378653;15360.23198840076;15390.692186156439;15566.610834729223;12787.695687997877;13304.86695133075;13322.600321990356;13334.266615335862;13486.12340197884;12594.24434533931;12645.74708505843;12687.619371418872;13167.407466664215;13308.334583270991;13039.543615973396;13233.669158271121;13577.59267221985;13631.65920851947;13773.311334433038;9741.512924353896;9821.36161149523;9969.202463802734;9988.60045598168;10196.031377019171;12808.74382512326;13034.152780069266;13231.735365292832;13287.734245315232;13379.197248165141 04:11:10 INFO - PID 9278 | |3;mootools.html;1385.113527342501;1421.616163635819;1422.7296813605415;1450.166154461185;1456.7086582683467;10958.726031849197;11531.423428828566;11629.360385178812;11646.010089142423;11843.230190037642;11607.419629018537;11745.47145378458;11797.351145686984;11797.646070617895;11816.054715622751;2375.8455700379463;2405.2062819269686;2416.8187385946126;2420.044082587377;2422.8909699063584;2254.402583315423;2342.3792694935855;2344.941376465585;2347.94130146746;2356.4815740537056;2266.761989991052;2280.1905323610126;2309;2310.1683393978155;2320.8143348532076;2216.9778302216932;2239.1826983151195;2278.737945136306;2294.1511640692884;2300.930972070824;2136.572685462914;2272.227442669484;2280.6579013147993;2292.56441276157;2293.8853057347064;11560.6531804046;11603.825942610867;11615.535378584846;11667.066634669207;11705.239159454693;6516.185476815398;6740.93259067408;6745.426638735713;6748.089007983908;6749.291324410964;3883.6310550497656;4067.6949228807957;4068.674506039539;4090.856820011315;4135.276326642826;1305.7910734282564;1355.5120156743565;1391.3808355281903;1406.7960145778907;1411.8517555656713;15570.610734731608;15594.220288985505;15646.765298520531;15689.764653530092;15735.763963540556;5205.531502164823;5256.658317209369;5360.195970604441;5583.274174357308;5652.236948012048;12661.620151395473;12675.93662031684;12677.112602117948;12711.364431778375;12739.745205095845;6593.736250549924;6618.371254730793;6623.768168114189;6638.137042184581;6648;6024.216851809237;6094.573379863456;6165.136880836686;6197;6242.406971337716;4189.518205406356;4286.571342865688;4316.589923957219;4350.543192964757;4376.008915943238;1214.1136970011764;1242.7203879127123;1253.22926400265;1256.9057320700983;1266.4301064520819;792.6868886789686;819.5492479136451;834.2200042959852;843.3042739739617;862.4825104937113;5965.642061476326;5976.641401515923;6017.398260173947;6085.665288409092;6240.625562466266;947.2989987409268;965.2229954886244;966.7148191283588;969.2100937735722;972.9659461918799;4328.632066274339;4408.867733967986;4511.503734589192;4591.278270648507;4650.465196502446;15210.16344101085;15260.694786104215;15389.615259618598;15401.22993850303;15657.921710391603;15151.318190681446;15313.770293445607;15376.923115384576;15448.691026179413;15697.215139242991;9204.263658907272;9283.442993420416;9298.628054877865;9320.161185493338;9328.766780830534;6805.251422343439;6861.931380686129;6893.862122757617;6899.0341352209725;6916.6166766647875;13517.526886558922;13586;13775.655608609864;13843.930780346034;13894.166350019032;13910.234937078152;14186.432542698589;14234.857651423354;14314.069585476911;14494.057886237782;8567.957160214159;8849.115088491357;8887.688930887389;8898.599563019809;8948.910510894808;11149.442527873736;11164;11200.38397888124;11259.887401125883;11268;9473.810523789347;9562.521873906417;9591.136797688241;9630;9755.21958243353;9308.255339572954;9387.202087822337;9428.340016199074;9584.137427631547;9615.711528654152;7910.288074073361;7951.165127661512;7998.84002319962;8039.236272554098;8050;5857;6011.308699499614;6265.655388953469;6293.118963345044;6293.685315734104;6394.616323020634;6396.488280937607;6402.199725034371;6404.775832845828;6458.1281526995135 04:11:10 INFO - PID 9278 | |4;prototype.html;410.9835606575737;419.37722482114054;434.39402034162345;435.99564004359945;440.66729619137544;5866.592017915702;6052.182955301044;6128.509719222463;6174.938250617498;6178.756153019662;5879.324392548125;5987.7604895804225;6029.457348838604;6040.758369665219;6062.939370606293;4769.284607308897;4787.186178349689;4820.855374338776;4827.106985207748;4850.927236091461;4436.378906953029;4591.484810012687;4592.74739889306;4594.609458196057;4819.204831202847;4534.909301813978;4535.365048893158;4544.818207271705;4555.498895121534;4579.427571553556;4566.109608626302;4583.083383323332;4592.632589392841;4595.747233902134;4611.849335597955;3841.5774264830848;3914.5693973662874;3945.8618948336957;3953.1303113315025;4018.979905100485;5870.911936320958;5911.852203694899;5914;5937.91093133599;5940.316863560703;5287.86780330491;5350.759215835258;5367.141257398836;5373.462653734634;5378.139497680352;6344.777932772377;6393.520485963571;6436.678166091723;6446.580972236789;6461.289258181596;4429.9778501107285;4437.711548749353;4444;4450.910981780378;4457;6508.511861610398;6702.262751097375;6743.831404214885;6771.762988295435;6817.488688348344;4601.12578610063;4609;4615.976920115378;4617.307403889444;4618.515055919147;4671.1548938169235;4671.976640116845;4678.994016286447;4680.204365257914;4690.437147542317;5308.867278317995;5364.785408583613;5395.21769343443;5402.324709411324;5418.187271909166;6264.123022776815;6420.935790642127;6432.06735023419;6451.774187903495;6458.515611329169;1575.6376033512356;1576.4009676322923;1582.596437908326;1586.904785712861;1587.8805442163248;1032.6764779246696;1045.17953406577;1061.7186445591924;1078.8112080385902;1087.9175220655497;6189.6286222826775;6208.596441231396;6214.9689251553455;6240.282367527792;6256.124142620037;6658.3674550917585;6670.4997125215805;6684.231313398924;6693.297203793629;6693.828579998481;6061.939380606225;6213.720382582795;6254.93666076768;6261.499080073583;6304.873902521924;3492.4237500812083;3516.2967406518287;3533.699635530957;3535.575730912307;3539.4159963605716;6815.93184068153;6959.408450281681;6984.2317345092;7016.508844380946;7025.859482810418;6825.146856642919;6830.453563714891;6831.931680683229;6843.931560684429;6844.691988860513;6756.020377045301;6961.338672826073;6984.580925144508;7041.92958070423;7064.540804847668;6660.367265109807;6661.533692641662;6676.365745254193;6691.732330706717;6711.530192886647;6480.384363485461;6531;6600.867982640224;6622.37087476689;6629.900551491828;6971.79084627462;6976.302369762983;6978.953157026283;7013.403860671696;7026.754063607954;4528.682992190515;4530.796114174804;4571.542845715535;4595.563421474954;4605.907881842411;6497.382748638872;6655.667216639052;6655.700493477708;6664.266930637529;6680.164979377578;6457.418832305115;6480.222373315232;6513.1532900722605;6518.837029074311;6519.511036672174;6461.256955450183;6537.489132498561;6544.116544266463;6572.901406479003;6584.9670751647855;6521.9673901630185;6546.934530654633;6548.869022619426;6552.27924928267;6560.507961902781;6384.265809431975;6577.177852768404;6582.3746744059235;6597.1423714916755;6600.8349791255605;6319.146915166394;6396.87401625958;6401.967990160019;6413.647249401328;6415.486761059011 04:11:10 INFO - PID 9278 | |5;yui.html;871.2333146830784;876.8640860666596;888.9511076890773;894.2979760887705;908.8500397434424;13137.27744974026;13573.389197486113;16060.196990150504;17317.567060823487;17428.738568921475;16773.83226167738;17244.82755172448;17568.385106521273;18123.184456699448;18265.45203643893;964.7491652170451;965.4207475514705;965.7344230336679;972.3388096094653;1003.844404117363;958.7698952251479;962.5764663548016;967.0619499085875;974.9171320437771;1023.9436830974294;1086.7337502311946;1086.8152414089584;1089.831076183189;1091.2034215022998;1091.6179337231986;1065.3714308557987;1070.2668671959693;1072.4744875011188;1075.8171110911126;1076.9084627806646;782.1162086841889;783.1972228465811;787.6140691061339;792.453207286976;794.364508393283;15973.520794376187;16205;16279.186040697918;16304.184790760533;16351.26419311134;17899;18429.170687319103;18580;18811.52971175718;18964.051797410073;14526.201058941753;14554.781678274834;14738.263086845614;14892.436294189063;14922;3147.8740850365957;3213.550102985584;3216.662250463691;3216.6783321667644;3220.2915358621067;87013.56493217494;87093.56453217757;88353.55823220906;88500.5574972121;89590;12790.168639038433;12930.224186548838;12970.027247956441;12976.870231297755;13132.606021819362;21727.891360543414;21891.12435502594;22144;22158.335249942527;22260;7840.960795195988;7911.248431399008;7988.920110798934;8048.919510804817;8077.596120193967;4088.509378874554;4112.794360281974;4128.752274863517;4170.374443833389;4182.372644103409;3853.499045124116;3876.9224615507533;3893.0462036801164;3915.138669492707;3920.9607903921165;937.840567103594;942.4392486470539;956.268454632207;961.3895176562933;966.5070813884829;719.2268311565089;727.1891840597696;728.4354625165539;731.579341878422;763.9236076392427;11865.466054027589;12100.33448160342;12445.626631200897;13266.40301186449;13328.800067998987;719.9820004499929;740.5926740292817;744.118219909409;749.2956620776453;750.5121670913841;5261.947380526146;5379.569634429236;5555.722213889289;5559.72201389937;5568.860778480571;79252.6037369821;80579;80624.59687701524;80650.5967470159;81969.59015204886;69514.00588932236;71050;72266.63866680634;73001.88986770876;73483;62164.68917655383;63218.36781632217;63474.682626586575;64715.35284647188;64969.67515162394;12281;12979;13166.802497962346;13284.269365185008;13302.46790128384;34150;35173.472397914564;35510.644893550736;35645;36344.45483317699;40700.59299406968;41113;41227.38158927678;41663.166736665706;42193.156136877704;16778.58053548671;17024.404145854834;17501.912490437466;17881.19534620919;17922.462326130237;19515.316963906196;19859.900700496404;19922.800771992093;19996.90001549983;20169.294074707315;15998.12010339396;16163.595910102342;16545.172741363123;18605.720914186568;19035.333763318216;16985.660286794442;17200.13999300055;17565;17775;18018.90990545039;17413.82586174122;17690;17759.289628414717;18182.363617273862;18471.722924155878;12516.436760345989;12929.54746583865;12969.184314196209;13333.466661333827;13759.931200343934;13533.93233033868;14828.184449855362;14859.257037148316;15004.474843380429;15110.244487775348 04:11:10 INFO - PID 9278 | __end_tp_report 04:11:10 INFO - PID 9278 | __start_cc_report 04:11:10 INFO - PID 9278 | _x_x_mozilla_cycle_collect,349 04:11:10 INFO - PID 9278 | __end_cc_report 04:11:10 INFO - PID 9278 | __startTimestamp1494069070245__endTimestamp 04:11:10 INFO - PID 9278 | 04:11:10 INFO - PID 9278 | ------- Summary: start ------- 04:11:10 INFO - PID 9278 | Number of tests: 6 04:11:10 INFO - PID 9278 | 04:11:10 INFO - PID 9278 | [#0] dojo.html Cycles:165 Average:5970.70 Median:6217.75 stddev:723.03 (11.6%) stddev-sans-first:695.40 04:11:10 INFO - PID 9278 | Values: 3350.0 3369.4 3377.0 3390.7 3396.5 5859.5 5878.2 5880.3 5914.5 5919.6 5919.1 5936.7 5975.0 5997.6 6015.5 4921.7 5260.3 5290.1 5303.2 5327.1 5345.6 5380.2 5384.5 5401.5 5407.1 5197.8 5221.4 5263.1 5276.4 5318.8 5314.1 5319.7 5364.5 5364.7 5388.0 5249.1 5269.6 5313.3 5316.4 5317.9 5842.9 5966.0 5972.3 5985.6 5988.0 6329.8 6367.8 6459.9 6470.6 6499.2 6492.4 6519.1 6529.8 6531.5 6548.5 5980.7 5992.3 6070.4 6075.3 6080.7 6423.1 6484.8 6513.2 6568.4 6611.8 6195.3 6211.3 6270.3 6365.8 6438.1 6364.9 6471.0 6478.0 6490.7 6504.7 6472.4 6480.6 6481.6 6494.8 6496.3 6265.0 6343.7 6354.8 6361.1 6485.9 4991.9 4997.7 4999.0 5008.1 5021.1 4367.7 4372.1 4375.0 4378.2 4415.2 6151.9 6160.6 6173.1 6185.6 6200.9 6268.8 6358.3 6414.0 6415.0 6507.5 6163.8 6184.2 6191.4 6192.5 6204.5 5682.5 5688.7 5699.1 5703.6 5724.5 6523.9 6690.0 6693.7 6764.9 6834.2 6502.3 6513.7 6525.2 6556.8 6559.3 6845.8 6853.2 6867.3 6867.6 6886.8 6240.2 6274.9 6314.3 6393.3 6443.8 6511.7 6522.6 6528.9 6555.5 6559.0 6245.6 6270.7 6338.3 6341.1 6359.7 6168.4 6229.1 6275.7 6360.0 6362.3 6258.5 6351.9 6355.9 6372.7 6378.8 6412.8 6421.6 6425.6 6436.5 6438.0 5992.2 6010.3 6044.2 6045.3 6217.8 04:11:10 INFO - PID 9278 | 04:11:10 INFO - PID 9278 | [#1] ext.html Cycles:180 Average:38377.68 Median:18994.37 stddev:57763.79 (304.1%) stddev-sans-first:57856.62 04:11:10 INFO - PID 9278 | Values: 717.6 773.9 784.7 1108.5 1110.8 34705.5 34925.8 35033.6 35159.0 35170.0 36537.5 36717.0 36772.6 36976.8 37124.0 6863.8 7016.3 7075.5 7178.5 7198.0 7034.6 7073.9 7079.6 7104.0 7172.4 7106.0 7162.8 7175.2 7183.2 7205.4 7070.3 7082.7 7093.9 7149.5 7167.9 7002.8 7051.1 7084.8 7090.2 7110.3 35107.8 35170.5 35380.3 35432.0 35564.0 3431.5 3449.7 3468.7 3470.6 3474.8 27519.3 27564.6 27600.0 27644.4 27650.7 3632.5 3684.9 3694.2 3701.8 3747.9 185660.0 185667.0 204625.0 208620.0 209424.0 44728.1 44842.0 44865.3 45054.8 45117.5 46099.8 46124.3 46196.1 46540.5 46644.3 14471.4 14480.0 14488.9 14498.7 14505.9 11732.4 11893.3 11907.2 11911.4 11938.2 13432.4 13455.7 13604.3 13631.0 13765.1 5560.6 5626.7 5701.1 5808.3 5828.4 1045.4 1091.8 1092.1 1096.5 1097.2 24363.4 24581.8 24654.6 24817.4 25278.0 1179.5 1182.1 1182.7 1188.9 1215.1 12972.5 13129.1 13164.2 17660.3 17675.2 247569.0 250458.0 250728.0 250854.0 252423.0 54652.2 54851.2 55265.4 55476.2 55615.7 1506.6 1521.5 1561.6 1562.1 1564.6 28708.6 30250.7 30257.0 30772.5 31285.4 37904.2 38143.4 38149.0 38445.8 38473.0 213612.0 214534.0 214881.0 215757.0 216224.0 33494.5 34456.7 34539.0 34795.8 34988.3 40648.2 41090.0 41744.8 41867.6 42248.2 31704.8 32032.5 32431.8 32824.7 33105.3 31771.2 32620.7 32887.5 33367.7 33384.7 35940.6 35996.3 36648.3 36906.1 37059.3 31069.7 31483.4 31859.2 31957.0 32037.4 23853.4 25870.5 26017.2 26286.0 26329.1 04:11:10 INFO - PID 9278 | 04:11:10 INFO - PID 9278 | [#2] jquery.html Cycles:180 Average:29737.78 Median:2212.77 stddev:74180.25 (3352.4%) stddev-sans-first:74355.72 04:11:10 INFO - PID 9278 | Values: 435.9 446.1 451.0 462.2 471.5 19621.5 20359.9 20703.0 20913.2 21039.6 21465.4 21982.8 22583.5 22596.7 23152.8 5447.2 5588.8 5626.4 5627.2 5646.1 5249.6 5463.8 5467.0 5479.5 5501.1 5434.4 5438.2 5470.6 5476.5 5484.8 5411.1 5413.1 5419.9 5422.5 5471.7 4851.5 4857.3 4886.6 4891.2 4904.1 24872.0 25234.9 25344.4 25551.4 25688.4 2119.7 2157.4 2165.1 2166.9 2167.1 17062.3 17308.8 17540.5 17615.3 17794.6 2113.2 2200.3 2217.8 2228.3 2236.8 106045.0 117061.0 121370.0 122702.0 122898.0 12432.2 12480.3 12634.9 12739.6 12848.9 17589.2 17612.3 17671.9 17699.0 17701.6 9267.9 9269.1 9297.7 9384.8 9458.2 8525.3 8541.2 8545.5 8776.4 8820.8 7960.1 8035.6 8144.8 8187.8 8196.4 2207.8 2235.7 2264.3 2277.7 2409.8 1011.4 1059.9 1073.1 1074.0 1075.8 18881.8 20151.5 20372.0 20387.5 20610.6 1076.6 1081.8 1082.6 1087.8 1089.5 10950.9 11435.4 11456.0 11477.3 11541.2 425608.0 429105.0 450231.0 454572.0 454725.0 92001.5 94080.0 94454.5 95205.5 95238.0 1176.3 1220.0 1234.0 1245.2 1263.8 16685.8 17087.3 17481.7 17769.6 18103.0 44612.0 44619.8 44813.3 45491.8 45734.8 54042.5 54303.0 54503.2 55076.4 55728.0 9420.9 9605.9 9643.4 9675.3 9761.8 14792.8 15148.9 15360.2 15390.7 15566.6 12787.7 13304.9 13322.6 13334.3 13486.1 12594.2 12645.7 12687.6 13167.4 13308.3 13039.5 13233.7 13577.6 13631.7 13773.3 9741.5 9821.4 9969.2 9988.6 10196.0 12808.7 13034.2 13231.7 13287.7 13379.2 04:11:10 INFO - PID 9278 | 04:11:10 INFO - PID 9278 | [#3] mootools.html Cycles:180 Average:7193.89 Median:3975.66 stddev:4598.46 (115.7%) stddev-sans-first:4590.65 04:11:10 INFO - PID 9278 | Values: 1385.1 1421.6 1422.7 1450.2 1456.7 10958.7 11531.4 11629.4 11646.0 11843.2 11607.4 11745.5 11797.4 11797.6 11816.1 2375.8 2405.2 2416.8 2420.0 2422.9 2254.4 2342.4 2344.9 2347.9 2356.5 2266.8 2280.2 2309.0 2310.2 2320.8 2217.0 2239.2 2278.7 2294.2 2300.9 2136.6 2272.2 2280.7 2292.6 2293.9 11560.7 11603.8 11615.5 11667.1 11705.2 6516.2 6740.9 6745.4 6748.1 6749.3 3883.6 4067.7 4068.7 4090.9 4135.3 1305.8 1355.5 1391.4 1406.8 1411.9 15570.6 15594.2 15646.8 15689.8 15735.8 5205.5 5256.7 5360.2 5583.3 5652.2 12661.6 12675.9 12677.1 12711.4 12739.7 6593.7 6618.4 6623.8 6638.1 6648.0 6024.2 6094.6 6165.1 6197.0 6242.4 4189.5 4286.6 4316.6 4350.5 4376.0 1214.1 1242.7 1253.2 1256.9 1266.4 792.7 819.5 834.2 843.3 862.5 5965.6 5976.6 6017.4 6085.7 6240.6 947.3 965.2 966.7 969.2 973.0 4328.6 4408.9 4511.5 4591.3 4650.5 15210.2 15260.7 15389.6 15401.2 15657.9 15151.3 15313.8 15376.9 15448.7 15697.2 9204.3 9283.4 9298.6 9320.2 9328.8 6805.3 6861.9 6893.9 6899.0 6916.6 13517.5 13586.0 13775.7 13843.9 13894.2 13910.2 14186.4 14234.9 14314.1 14494.1 8568.0 8849.1 8887.7 8898.6 8948.9 11149.4 11164.0 11200.4 11259.9 11268.0 9473.8 9562.5 9591.1 9630.0 9755.2 9308.3 9387.2 9428.3 9584.1 9615.7 7910.3 7951.2 7998.8 8039.2 8050.0 5857.0 6011.3 6265.7 6293.1 6293.7 6394.6 6396.5 6402.2 6404.8 6458.1 04:11:10 INFO - PID 9278 | 04:11:10 INFO - PID 9278 | [#4] prototype.html Cycles:180 Average:5414.50 Median:6184.19 stddev:1645.58 (26.6%) stddev-sans-first:1606.77 04:11:10 INFO - PID 9278 | Values: 411.0 419.4 434.4 436.0 440.7 5866.6 6052.2 6128.5 6174.9 6178.8 5879.3 5987.8 6029.5 6040.8 6062.9 4769.3 4787.2 4820.9 4827.1 4850.9 4436.4 4591.5 4592.7 4594.6 4819.2 4534.9 4535.4 4544.8 4555.5 4579.4 4566.1 4583.1 4592.6 4595.7 4611.8 3841.6 3914.6 3945.9 3953.1 4019.0 5870.9 5911.9 5914.0 5937.9 5940.3 5287.9 5350.8 5367.1 5373.5 5378.1 6344.8 6393.5 6436.7 6446.6 6461.3 4430.0 4437.7 4444.0 4450.9 4457.0 6508.5 6702.3 6743.8 6771.8 6817.5 4601.1 4609.0 4616.0 4617.3 4618.5 4671.2 4672.0 4679.0 4680.2 4690.4 5308.9 5364.8 5395.2 5402.3 5418.2 6264.1 6420.9 6432.1 6451.8 6458.5 1575.6 1576.4 1582.6 1586.9 1587.9 1032.7 1045.2 1061.7 1078.8 1087.9 6189.6 6208.6 6215.0 6240.3 6256.1 6658.4 6670.5 6684.2 6693.3 6693.8 6061.9 6213.7 6254.9 6261.5 6304.9 3492.4 3516.3 3533.7 3535.6 3539.4 6815.9 6959.4 6984.2 7016.5 7025.9 6825.1 6830.5 6831.9 6843.9 6844.7 6756.0 6961.3 6984.6 7041.9 7064.5 6660.4 6661.5 6676.4 6691.7 6711.5 6480.4 6531.0 6600.9 6622.4 6629.9 6971.8 6976.3 6979.0 7013.4 7026.8 4528.7 4530.8 4571.5 4595.6 4605.9 6497.4 6655.7 6655.7 6664.3 6680.2 6457.4 6480.2 6513.2 6518.8 6519.5 6461.3 6537.5 6544.1 6572.9 6585.0 6522.0 6546.9 6548.9 6552.3 6560.5 6384.3 6577.2 6582.4 6597.1 6600.8 6319.1 6396.9 6402.0 6413.6 6415.5 04:11:10 INFO - PID 9278 | 04:11:10 INFO - PID 9278 | [#5] yui.html Cycles:180 Average:18746.64 Median:22209.17 stddev:22620.97 (101.9%) stddev-sans-first:22644.60 04:11:10 INFO - PID 9278 | Values: 871.2 876.9 889.0 894.3 908.9 13137.3 13573.4 16060.2 17317.6 17428.7 16773.8 17244.8 17568.4 18123.2 18265.5 964.7 965.4 965.7 972.3 1003.8 958.8 962.6 967.1 974.9 1023.9 1086.7 1086.8 1089.8 1091.2 1091.6 1065.4 1070.3 1072.5 1075.8 1076.9 782.1 783.2 787.6 792.5 794.4 15973.5 16205.0 16279.2 16304.2 16351.3 17899.0 18429.2 18580.0 18811.5 18964.1 14526.2 14554.8 14738.3 14892.4 14922.0 3147.9 3213.6 3216.7 3216.7 3220.3 87013.6 87093.6 88353.6 88500.6 89590.0 12790.2 12930.2 12970.0 12976.9 13132.6 21727.9 21891.1 22144.0 22158.3 22260.0 7841.0 7911.2 7988.9 8048.9 8077.6 4088.5 4112.8 4128.8 4170.4 4182.4 3853.5 3876.9 3893.0 3915.1 3921.0 937.8 942.4 956.3 961.4 966.5 719.2 727.2 728.4 731.6 763.9 11865.5 12100.3 12445.6 13266.4 13328.8 720.0 740.6 744.1 749.3 750.5 5261.9 5379.6 5555.7 5559.7 5568.9 79252.6 80579.0 80624.6 80650.6 81969.6 69514.0 71050.0 72266.6 73001.9 73483.0 62164.7 63218.4 63474.7 64715.4 64969.7 12281.0 12979.0 13166.8 13284.3 13302.5 34150.0 35173.5 35510.6 35645.0 36344.5 40700.6 41113.0 41227.4 41663.2 42193.2 16778.6 17024.4 17501.9 17881.2 17922.5 19515.3 19859.9 19922.8 19996.9 20169.3 15998.1 16163.6 16545.2 18605.7 19035.3 16985.7 17200.1 17565.0 17775.0 18018.9 17413.8 17690.0 17759.3 18182.4 18471.7 12516.4 12929.5 12969.2 13333.5 13759.9 13533.9 14828.2 14859.3 15004.5 15110.2 04:11:10 INFO - PID 9278 | -------- Summary: end -------- 04:11:10 INFO - PID 9278 | 04:11:11 INFO - TEST-INFO | 9278: exit 0 04:11:11 INFO - TEST-OK | dromaeo_css | took 1113161ms 04:11:11 INFO - TEST-START | kraken 04:11:11 INFO - operating with platform_type : linux_ 04:11:11 INFO - Initialising browser for kraken test... 04:11:11 INFO - TEST-INFO | started process 9696 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMAL6e_/profile http://localhost:57902/getInfo.html) 04:11:14 INFO - PID 9696 | __metrics Screen width/height:1600/1200 04:11:14 INFO - PID 9696 | colorDepth:24 04:11:14 INFO - PID 9696 | Browser inner width/height: 1024/695 04:11:14 INFO - PID 9696 | __metrics 04:11:16 INFO - TEST-INFO | 9696: exit 0 04:11:16 INFO - Browser initialized. 04:11:16 INFO - Running cycle 1/1 for kraken test... 04:11:16 INFO - TEST-INFO | started process 9867 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMAL6e_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:11:28 INFO - PID 9867 | RSS: Main: 156844032 04:11:28 INFO - PID 9867 | 04:11:30 INFO - PID 9867 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57902/tests/kraken/driver.html?testName=audio-beat-detection) 04:11:31 INFO - PID 9867 | RSS: Main: 163475456 04:11:31 INFO - PID 9867 | 04:11:34 INFO - PID 9867 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57902/tests/kraken/driver.html?testName=audio-dft) 04:11:34 INFO - PID 9867 | RSS: Main: 160976896 04:11:34 INFO - PID 9867 | 04:11:37 INFO - PID 9867 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57902/tests/kraken/driver.html?testName=audio-fft) 04:11:38 INFO - PID 9867 | RSS: Main: 157515776 04:11:38 INFO - PID 9867 | 04:11:40 INFO - PID 9867 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57902/tests/kraken/driver.html?testName=audio-oscillator) 04:11:41 INFO - PID 9867 | RSS: Main: 158789632 04:11:41 INFO - PID 9867 | 04:11:43 INFO - PID 9867 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57902/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:11:43 INFO - PID 9867 | RSS: Main: 158490624 04:11:43 INFO - PID 9867 | 04:11:46 INFO - PID 9867 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57902/tests/kraken/driver.html?testName=imaging-darkroom) 04:11:47 INFO - PID 9867 | RSS: Main: 163237888 04:11:47 INFO - PID 9867 | 04:11:50 INFO - PID 9867 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57902/tests/kraken/driver.html?testName=imaging-desaturate) 04:11:51 INFO - PID 9867 | RSS: Main: 166187008 04:11:51 INFO - PID 9867 | 04:11:54 INFO - PID 9867 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57902/tests/kraken/driver.html?testName=json-parse-financial) 04:11:54 INFO - PID 9867 | RSS: Main: 165376000 04:11:54 INFO - PID 9867 | 04:11:56 INFO - PID 9867 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57902/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:11:56 INFO - PID 9867 | RSS: Main: 164622336 04:11:56 INFO - PID 9867 | 04:11:58 INFO - PID 9867 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57902/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:11:59 INFO - PID 9867 | RSS: Main: 165269504 04:11:59 INFO - PID 9867 | 04:12:01 INFO - PID 9867 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57902/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:12:01 INFO - PID 9867 | RSS: Main: 165507072 04:12:01 INFO - PID 9867 | 04:12:04 INFO - PID 9867 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57902/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:12:05 INFO - PID 9867 | RSS: Main: 164962304 04:12:05 INFO - PID 9867 | 04:12:08 INFO - PID 9867 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57902/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:12:08 INFO - PID 9867 | RSS: Main: 165515264 04:12:08 INFO - PID 9867 | 04:12:10 INFO - PID 9867 | Cycle 1(1): loaded http://localhost:57902/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57902/tests/kraken/driver.html?testName=ai-astar) 04:12:10 INFO - PID 9867 | RSS: Main: 167800832 04:12:10 INFO - PID 9867 | 04:12:10 INFO - PID 9867 | __start_tp_report 04:12:10 INFO - PID 9867 | _x_x_mozilla_page_load 04:12:10 INFO - PID 9867 | _x_x_mozilla_page_load_details 04:12:10 INFO - PID 9867 | |i|pagename|runs| 04:12:10 INFO - PID 9867 | |0;ai-astar;103;110;111;109;109;112;110;111;110;110 04:12:10 INFO - PID 9867 | |1;audio-beat-detection;153;117;117;172;123;118;117;119;138;123 04:12:10 INFO - PID 9867 | |2;audio-dft;164;166;165;161;163;166;165;172;168;166 04:12:10 INFO - PID 9867 | |3;audio-fft;73;75;75;96;75;75;73;74;98;74 04:12:10 INFO - PID 9867 | |4;audio-oscillator;83;83;114;82;83;83;94;83;82;118 04:12:10 INFO - PID 9867 | |5;imaging-gaussian-blur;114;114;114;114;113;113;114;114;113;114 04:12:10 INFO - PID 9867 | |6;imaging-darkroom;148;148;149;150;149;147;150;149;148;149 04:12:10 INFO - PID 9867 | |7;imaging-desaturate;95;95;100;94;95;95;95;94;94;95 04:12:10 INFO - PID 9867 | |8;json-parse-financial;48;48;48;48;47;47;50;51;48;51 04:12:10 INFO - PID 9867 | |9;json-stringify-tinderbox;57;56;55;56;55;55;56;56;55;56 04:12:10 INFO - PID 9867 | |10;stanford-crypto-aes;82;82;82;82;88;81;82;82;88;82 04:12:10 INFO - PID 9867 | |11;stanford-crypto-ccm;138;128;137;125;126;127;131;128;225;131 04:12:10 INFO - PID 9867 | |12;stanford-crypto-pbkdf2;178;184;183;189;188;190;192;184;184;185 04:12:10 INFO - PID 9867 | |13;stanford-crypto-sha256-iterative;69;67;69;66;68;68;66;65;64;66 04:12:10 INFO - PID 9867 | __end_tp_report 04:12:10 INFO - PID 9867 | __start_cc_report 04:12:10 INFO - PID 9867 | _x_x_mozilla_cycle_collect,784 04:12:10 INFO - PID 9867 | __end_cc_report 04:12:10 INFO - PID 9867 | __startTimestamp1494069130824__endTimestamp 04:12:10 INFO - PID 9867 | 04:12:10 INFO - PID 9867 | ------- Summary: start ------- 04:12:10 INFO - PID 9867 | Number of tests: 14 04:12:10 INFO - PID 9867 | 04:12:10 INFO - PID 9867 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:2.46 (2.2%) stddev-sans-first:0.97 04:12:10 INFO - PID 9867 | Values: 103.0 110.0 111.0 109.0 109.0 112.0 110.0 111.0 110.0 110.0 04:12:10 INFO - PID 9867 | 04:12:10 INFO - PID 9867 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:123.00 stddev:18.93 (15.4%) stddev-sans-first:18.11 04:12:10 INFO - PID 9867 | Values: 153.0 117.0 117.0 172.0 123.0 118.0 117.0 119.0 138.0 123.0 04:12:10 INFO - PID 9867 | 04:12:10 INFO - PID 9867 | [#2] audio-dft Cycles:10 Average:165.60 Median:166.00 stddev:2.95 (1.8%) stddev-sans-first:3.07 04:12:10 INFO - PID 9867 | Values: 164.0 166.0 165.0 161.0 163.0 166.0 165.0 172.0 168.0 166.0 04:12:10 INFO - PID 9867 | 04:12:10 INFO - PID 9867 | [#3] audio-fft Cycles:10 Average:78.80 Median:75.00 stddev:9.64 (12.8%) stddev-sans-first:9.99 04:12:10 INFO - PID 9867 | Values: 73.0 75.0 75.0 96.0 75.0 75.0 73.0 74.0 98.0 74.0 04:12:10 INFO - PID 9867 | 04:12:10 INFO - PID 9867 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:83.00 stddev:13.93 (16.8%) stddev-sans-first:14.51 04:12:10 INFO - PID 9867 | Values: 83.0 83.0 114.0 82.0 83.0 83.0 94.0 83.0 82.0 118.0 04:12:10 INFO - PID 9867 | 04:12:10 INFO - PID 9867 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:12:10 INFO - PID 9867 | Values: 114.0 114.0 114.0 114.0 113.0 113.0 114.0 114.0 113.0 114.0 04:12:10 INFO - PID 9867 | 04:12:10 INFO - PID 9867 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 04:12:10 INFO - PID 9867 | Values: 148.0 148.0 149.0 150.0 149.0 147.0 150.0 149.0 148.0 149.0 04:12:10 INFO - PID 9867 | 04:12:10 INFO - PID 9867 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:1.75 (1.8%) stddev-sans-first:1.86 04:12:10 INFO - PID 9867 | Values: 95.0 95.0 100.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 04:12:10 INFO - PID 9867 | 04:12:10 INFO - PID 9867 | [#8] json-parse-financial Cycles:10 Average:48.60 Median:48.00 stddev:1.51 (3.1%) stddev-sans-first:1.58 04:12:10 INFO - PID 9867 | Values: 48.0 48.0 48.0 48.0 47.0 47.0 50.0 51.0 48.0 51.0 04:12:10 INFO - PID 9867 | 04:12:10 INFO - PID 9867 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:56.00 stddev:0.67 (1.2%) stddev-sans-first:0.53 04:12:10 INFO - PID 9867 | Values: 57.0 56.0 55.0 56.0 55.0 55.0 56.0 56.0 55.0 56.0 04:12:10 INFO - PID 9867 | 04:12:10 INFO - PID 9867 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:82.00 stddev:2.60 (3.2%) stddev-sans-first:2.73 04:12:10 INFO - PID 9867 | Values: 82.0 82.0 82.0 82.0 88.0 81.0 82.0 82.0 88.0 82.0 04:12:10 INFO - PID 9867 | 04:12:10 INFO - PID 9867 | [#11] stanford-crypto-ccm Cycles:10 Average:139.60 Median:131.00 stddev:30.32 (23.1%) stddev-sans-first:32.16 04:12:10 INFO - PID 9867 | Values: 138.0 128.0 137.0 125.0 126.0 127.0 131.0 128.0 225.0 131.0 04:12:10 INFO - PID 9867 | 04:12:10 INFO - PID 9867 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.70 Median:186.50 stddev:4.08 (2.2%) stddev-sans-first:3.24 04:12:10 INFO - PID 9867 | Values: 178.0 184.0 183.0 189.0 188.0 190.0 192.0 184.0 184.0 185.0 04:12:10 INFO - PID 9867 | 04:12:10 INFO - PID 9867 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.50 stddev:1.69 (2.5%) stddev-sans-first:1.59 04:12:10 INFO - PID 9867 | Values: 69.0 67.0 69.0 66.0 68.0 68.0 66.0 65.0 64.0 66.0 04:12:10 INFO - PID 9867 | -------- Summary: end -------- 04:12:10 INFO - PID 9867 | 04:12:11 INFO - TEST-INFO | 9867: exit 0 04:12:12 INFO - TEST-OK | kraken | took 60991ms 04:12:12 INFO - SUITE-END | took 1174s 04:12:12 INFO - Completed test suite (00:19:34) 04:12:12 INFO - javascript benchmark 04:12:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7781.495568792178, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3349.9665003349974, 3369.4440417331143, 3377.0375442998743, 3390.745694072942, 3396.4565669492886, 5859.501942334901, 5878.23582934219, 5880.2649668791455, 5914.497267732238, 5919.615225010371, 5919.141724449953, 5936.703164841762, 5974.970125149379, 5997.580169388145, 6015.488683461911, 4921.732799417547, 5260.342457192851, 5290.074237008527, 5303.15149576067, 5327.121025030885, 5345.572354211673, 5380.192971054354, 5384.542313903304, 5401.540869026137, 5407.080796264625, 5197.7920883164625, 5221.425643179247, 5263.105272103751, 5276.445973172838, 5318.760655770499, 5314.096603577401, 5319.7340132993195, 5364.463553644643, 5364.704941228231, 5388.0, 5249.055170069386, 5269.552088072518, 5313.335833020872, 5316.3620365556, 5317.9202311965355, 5842.941570584282, 5966.0454327307425, 5972.343042265347, 5985.551083668743, 5988.0, 6329.810105696836, 6367.8408039798915, 6459.903101453482, 6470.611763294218, 6499.155109835739, 6492.448141907944, 6519.087327774116, 6529.771457998995, 6531.510136739764, 6548.476121910284, 5980.700964951735, 5992.310884248323, 6070.3929607038945, 6075.301340345873, 6080.695965201722, 6423.068655044993, 6484.837879053061, 6513.218413790375, 6568.408843204134, 6611.801645950629, 6195.349488303754, 6211.254649442006, 6270.341614130451, 6365.777197798147, 6438.098666186644, 6364.872702545923, 6470.967645161744, 6478.0, 6490.675466226764, 6504.739810407531, 6472.352764723584, 6480.611163330121, 6481.578697384655, 6494.772682956168, 6496.285408605049, 6264.968675156595, 6343.746250149942, 6354.777582784581, 6361.077643741724, 6485.935140648628, 4991.925121123186, 4997.725125118153, 4998.9500104999215, 5008.098542262428, 5021.07110184617, 4367.694261401672, 4372.125574884972, 4374.956250437519, 4378.2119218540965, 4415.227335216325, 6151.938480615226, 6160.599561028519, 6173.074038894202, 6185.628862268279, 6200.906986395207, 6268.843278918063, 6358.33237510064, 6414.037894315797, 6415.0, 6507.479401647857, 6163.84590385244, 6184.165137706442, 6191.4118158774845, 6192.535559833031, 6204.534659900525, 5682.460166284196, 5688.744006519716, 5699.145128230799, 5703.600747947687, 5724.513416359573, 6523.934760652428, 6690.0, 6693.698783554752, 6764.864702706017, 6834.214065382345, 6502.317256687979, 6513.674316284072, 6525.184351956005, 6556.770513032021, 6559.27847936717, 6845.828854278683, 6853.246142924374, 6867.313268673092, 6867.587944723333, 6886.793396198122, 6240.157578726996, 6274.905876411949, 6314.336994615683, 6393.29673735898, 6443.806685799434, 6511.73953041873, 6522.5760325578685, 6528.934710652833, 6555.508336874849, 6558.967205163944, 6245.588220673553, 6270.686465676789, 6338.271098823509, 6341.112244285896, 6359.745610175726, 6168.383161683975, 6229.127922091002, 6275.717592708431, 6360.014197799349, 6362.331955144643, 6258.530610204162, 6351.904721429275, 6355.936440635534, 6372.74509019634, 6378.840528986812, 6412.839679008062, 6421.550491465552, 6425.614463132227, 6436.517261205335, 6438.0, 5992.221011268507, 6010.308814486215, 6044.24446944132, 6045.304789949212, 6217.751289948352], "value": 5918.714289076196, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.6268340462959, 773.8529679360921, 784.7292684024012, 1108.512254607972, 1110.8278216876377, 34705.479417808754, 34925.82537087311, 35033.649663503355, 35159.0, 35170.0, 36537.45193822088, 36717.0, 36772.632273677256, 36976.81511592445, 37124.0, 6863.7597684081065, 7016.298370162994, 7075.540089894166, 7178.461615378841, 7198.0, 7034.6482675866255, 7073.858522829541, 7079.575225486462, 7104.040954471157, 7172.426205903515, 7106.040684507603, 7162.8209294767785, 7175.174854891676, 7183.245759195288, 7205.423566114699, 7070.2576229495935, 7082.681279342442, 7093.929060709378, 7149.53528020677, 7167.89248161278, 7002.75490357835, 7051.083359163327, 7084.752033678848, 7090.220075791659, 7110.32451917067, 35107.82446087779, 35170.47244291338, 35380.29239415223, 35432.0, 35564.0, 3431.5367425397503, 3449.741269404805, 3468.670476304747, 3470.583529976394, 3474.774139680913, 27519.31201719973, 27564.586531201847, 27600.0, 27644.447111057667, 27650.723492765017, 3632.4732913727626, 3684.889453316405, 3694.224212915291, 3701.796401197933, 3747.9063023424633, 185660.0, 185667.0, 204625.0, 208619.95690021606, 209424.0, 44728.10543789106, 44842.0, 44865.32702009472, 45054.77472612616, 45117.54882451199, 46099.76950115295, 46124.30813537799, 46196.07607847824, 46540.53459465362, 46644.300335495, 14471.421143154366, 14480.0, 14488.927555362156, 14498.710025799635, 14505.854941450661, 11732.413379331, 11893.345865977455, 11907.226030308002, 11911.404429778477, 11938.22401543897, 13432.395542200624, 13455.663608409672, 13604.251766152758, 13631.0, 13765.105268157538, 5560.610757247035, 5626.690532020778, 5701.116326969326, 5808.30300363959, 5828.358880523139, 1045.38844775807, 1091.8034753744244, 1092.088106431123, 1096.4736926275432, 1097.1661537231762, 24363.39091522726, 24581.754182457946, 24654.630180547305, 24817.379565510644, 25278.0, 1179.4515550268995, 1182.0543565148018, 1182.6511179202157, 1188.9346085965183, 1215.1311812054423, 12972.545960891512, 13129.080964332596, 13164.210147391188, 17660.293588256325, 17675.20461579232, 247569.0, 250458.0, 250728.0, 250854.0, 252423.0, 54652.18021729677, 54851.17723234155, 55265.44734552683, 55476.16785748217, 55615.72192139013, 1506.6308754355252, 1521.4826958834271, 1561.5705680937833, 1562.093985488414, 1564.5932057665088, 28708.569371459027, 30250.69749302567, 30257.0, 30772.53841192339, 31285.374292514476, 37904.24191516209, 38143.42784858285, 38149.046273842265, 38445.807770960964, 38473.0, 213612.0, 214534.0, 214881.0, 215757.0, 216224.0, 33494.49758253579, 34456.65543344535, 34539.0, 34795.82602086973, 34988.30023399467, 40648.187036259704, 41090.0, 41744.79127604343, 41867.58132418759, 42248.155036898475, 31704.841475793397, 32032.5195122078, 32431.837840810644, 32824.671753282164, 33105.33789324248, 31771.205719856265, 32620.673793261765, 32887.50668739923, 33367.66632333743, 33384.666153338156, 35940.64059359478, 35996.28007439889, 36648.26703465969, 36906.077348066516, 37059.25881482409, 31069.68930310668, 31483.370332593677, 31859.20351991219, 31957.0, 32037.35925281528, 23853.403664908517, 25870.482590348463, 26017.219483415527, 26286.0, 26329.07848225303], "value": 16913.17972807261, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.8975640724431, 446.09442831052974, 450.95715906988823, 462.1611774629048, 471.50962998481583, 19621.50946226343, 20359.898200508997, 20703.0, 20913.16347346108, 21039.579208415824, 21465.356039318805, 21982.780172198272, 22583.54832903341, 22596.66105008426, 23152.76847231527, 5447.210154527581, 5588.776448942038, 5626.352969408509, 5627.184058311543, 5646.124850648156, 5249.580033597303, 5463.808766693167, 5467.043267428204, 5479.506844384005, 5501.092319767234, 5434.402215756264, 5438.238646589481, 5470.617056806025, 5476.452354764531, 5484.808031718891, 5411.053065713504, 5413.106837371829, 5419.891602167974, 5422.457754224585, 5471.671699698031, 4851.539103785135, 4857.34425852509, 4886.60907127429, 4891.241857512091, 4904.092742842586, 24872.005119795187, 25234.873825630937, 25344.36639084019, 25551.361215969562, 25688.357791055187, 2119.671450925109, 2157.3959291398432, 2165.1339464214284, 2166.9349919502442, 2167.0681606909025, 17062.317507299693, 17308.82691173085, 17540.473785786446, 17615.29538818446, 17794.55513612157, 2113.2392338758036, 2200.3179014505554, 2217.7782221777857, 2228.331500549845, 2236.8322375821876, 106045.0, 117061.0, 121370.0, 122702.0, 122898.0, 12432.191907525981, 12480.251184928933, 12634.936825316, 12739.55411560591, 12848.852031252403, 17589.20848561818, 17612.29550817953, 17671.911640441973, 17699.0, 17701.55746106332, 9267.907320926704, 9269.073092690813, 9297.67458138962, 9384.812303754023, 9458.196053335543, 8525.31797456202, 8541.188587084342, 8545.529995850287, 8776.385653004356, 8820.779480513038, 7960.124386317616, 8035.55804430762, 8144.837103257902, 8187.795305117301, 8196.42625016243, 2207.75714671386, 2235.742889567688, 2264.2904607021924, 2277.658351247326, 2409.8433601815827, 1011.4285428732743, 1059.8728152621734, 1073.0664322039875, 1074.0441007503327, 1075.7848430313968, 18881.811181888006, 20151.496212594804, 20372.0, 20387.4903127423, 20610.587788244153, 1076.5586109694987, 1081.8377243413552, 1082.6373164989816, 1087.7661302819931, 1089.5260561655705, 10950.945245273882, 11435.428228588704, 11456.0, 11477.311361318347, 11541.249818761753, 425608.0, 429105.0, 450231.0, 454572.0, 454725.0, 92001.53999229961, 94080.0, 94454.52772736092, 95205.52397238108, 95238.0, 1176.335370515656, 1219.9634010979685, 1233.975320493585, 1245.2404033539533, 1263.7788387032233, 16685.833141668427, 17087.31650733957, 17481.650366992333, 17769.644607108043, 18103.0, 44612.0, 44619.77690111659, 44813.32780008368, 45491.772541137085, 45734.771326143156, 54042.459575403744, 54303.0, 54503.18245226404, 55076.449235507134, 55728.0, 9420.905790942003, 9605.903940960781, 9643.421394716339, 9675.274354423305, 9761.804763904824, 14792.778108328599, 15148.924255378653, 15360.23198840076, 15390.692186156439, 15566.610834729223, 12787.695687997877, 13304.86695133075, 13322.600321990356, 13334.266615335862, 13486.12340197884, 12594.24434533931, 12645.74708505843, 12687.619371418872, 13167.407466664215, 13308.334583270991, 13039.543615973396, 13233.669158271121, 13577.59267221985, 13631.65920851947, 13773.311334433038, 9741.512924353896, 9821.36161149523, 9969.202463802734, 9988.60045598168, 10196.031377019171, 12808.74382512326, 13034.152780069266, 13231.735365292832, 13287.734245315232, 13379.197248165141], "value": 10182.30289606836, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.113527342501, 1421.616163635819, 1422.7296813605415, 1450.166154461185, 1456.7086582683467, 10958.726031849197, 11531.423428828566, 11629.360385178812, 11646.010089142423, 11843.230190037642, 11607.419629018537, 11745.47145378458, 11797.351145686984, 11797.646070617895, 11816.054715622751, 2375.8455700379463, 2405.2062819269686, 2416.8187385946126, 2420.044082587377, 2422.8909699063584, 2254.402583315423, 2342.3792694935855, 2344.941376465585, 2347.94130146746, 2356.4815740537056, 2266.761989991052, 2280.1905323610126, 2309.0, 2310.1683393978155, 2320.8143348532076, 2216.9778302216932, 2239.1826983151195, 2278.737945136306, 2294.1511640692884, 2300.930972070824, 2136.572685462914, 2272.227442669484, 2280.6579013147993, 2292.56441276157, 2293.8853057347064, 11560.6531804046, 11603.825942610867, 11615.535378584846, 11667.066634669207, 11705.239159454693, 6516.185476815398, 6740.93259067408, 6745.426638735713, 6748.089007983908, 6749.291324410964, 3883.6310550497656, 4067.6949228807957, 4068.674506039539, 4090.856820011315, 4135.276326642826, 1305.7910734282564, 1355.5120156743565, 1391.3808355281903, 1406.7960145778907, 1411.8517555656713, 15570.610734731608, 15594.220288985505, 15646.765298520531, 15689.764653530092, 15735.763963540556, 5205.531502164823, 5256.658317209369, 5360.195970604441, 5583.274174357308, 5652.236948012048, 12661.620151395473, 12675.93662031684, 12677.112602117948, 12711.364431778375, 12739.745205095845, 6593.736250549924, 6618.371254730793, 6623.768168114189, 6638.137042184581, 6648.0, 6024.216851809237, 6094.573379863456, 6165.136880836686, 6197.0, 6242.406971337716, 4189.518205406356, 4286.571342865688, 4316.589923957219, 4350.543192964757, 4376.008915943238, 1214.1136970011764, 1242.7203879127123, 1253.22926400265, 1256.9057320700983, 1266.4301064520819, 792.6868886789686, 819.5492479136451, 834.2200042959852, 843.3042739739617, 862.4825104937113, 5965.642061476326, 5976.641401515923, 6017.398260173947, 6085.665288409092, 6240.625562466266, 947.2989987409268, 965.2229954886244, 966.7148191283588, 969.2100937735722, 972.9659461918799, 4328.632066274339, 4408.867733967986, 4511.503734589192, 4591.278270648507, 4650.465196502446, 15210.16344101085, 15260.694786104215, 15389.615259618598, 15401.22993850303, 15657.921710391603, 15151.318190681446, 15313.770293445607, 15376.923115384576, 15448.691026179413, 15697.215139242991, 9204.263658907272, 9283.442993420416, 9298.628054877865, 9320.161185493338, 9328.766780830534, 6805.251422343439, 6861.931380686129, 6893.862122757617, 6899.0341352209725, 6916.6166766647875, 13517.526886558922, 13586.0, 13775.655608609864, 13843.930780346034, 13894.166350019032, 13910.234937078152, 14186.432542698589, 14234.857651423354, 14314.069585476911, 14494.057886237782, 8567.957160214159, 8849.115088491357, 8887.688930887389, 8898.599563019809, 8948.910510894808, 11149.442527873736, 11164.0, 11200.38397888124, 11259.887401125883, 11268.0, 9473.810523789347, 9562.521873906417, 9591.136797688241, 9630.0, 9755.21958243353, 9308.255339572954, 9387.202087822337, 9428.340016199074, 9584.137427631547, 9615.711528654152, 7910.288074073361, 7951.165127661512, 7998.84002319962, 8039.236272554098, 8050.0, 5857.0, 6011.308699499614, 6265.655388953469, 6293.118963345044, 6293.685315734104, 6394.616323020634, 6396.488280937607, 6402.199725034371, 6404.775832845828, 6458.1281526995135], "value": 5403.030741201779, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.9835606575737, 419.37722482114054, 434.39402034162345, 435.99564004359945, 440.66729619137544, 5866.592017915702, 6052.182955301044, 6128.509719222463, 6174.938250617498, 6178.756153019662, 5879.324392548125, 5987.7604895804225, 6029.457348838604, 6040.758369665219, 6062.939370606293, 4769.284607308897, 4787.186178349689, 4820.855374338776, 4827.106985207748, 4850.927236091461, 4436.378906953029, 4591.484810012687, 4592.74739889306, 4594.609458196057, 4819.204831202847, 4534.909301813978, 4535.365048893158, 4544.818207271705, 4555.498895121534, 4579.427571553556, 4566.109608626302, 4583.083383323332, 4592.632589392841, 4595.747233902134, 4611.849335597955, 3841.5774264830848, 3914.5693973662874, 3945.8618948336957, 3953.1303113315025, 4018.979905100485, 5870.911936320958, 5911.852203694899, 5914.0, 5937.91093133599, 5940.316863560703, 5287.86780330491, 5350.759215835258, 5367.141257398836, 5373.462653734634, 5378.139497680352, 6344.777932772377, 6393.520485963571, 6436.678166091723, 6446.580972236789, 6461.289258181596, 4429.9778501107285, 4437.711548749353, 4444.0, 4450.910981780378, 4457.0, 6508.511861610398, 6702.262751097375, 6743.831404214885, 6771.762988295435, 6817.488688348344, 4601.12578610063, 4609.0, 4615.976920115378, 4617.307403889444, 4618.515055919147, 4671.1548938169235, 4671.976640116845, 4678.994016286447, 4680.204365257914, 4690.437147542317, 5308.867278317995, 5364.785408583613, 5395.21769343443, 5402.324709411324, 5418.187271909166, 6264.123022776815, 6420.935790642127, 6432.06735023419, 6451.774187903495, 6458.515611329169, 1575.6376033512356, 1576.4009676322923, 1582.596437908326, 1586.904785712861, 1587.8805442163248, 1032.6764779246696, 1045.17953406577, 1061.7186445591924, 1078.8112080385902, 1087.9175220655497, 6189.6286222826775, 6208.596441231396, 6214.9689251553455, 6240.282367527792, 6256.124142620037, 6658.3674550917585, 6670.4997125215805, 6684.231313398924, 6693.297203793629, 6693.828579998481, 6061.939380606225, 6213.720382582795, 6254.93666076768, 6261.499080073583, 6304.873902521924, 3492.4237500812083, 3516.2967406518287, 3533.699635530957, 3535.575730912307, 3539.4159963605716, 6815.93184068153, 6959.408450281681, 6984.2317345092, 7016.508844380946, 7025.859482810418, 6825.146856642919, 6830.453563714891, 6831.931680683229, 6843.931560684429, 6844.691988860513, 6756.020377045301, 6961.338672826073, 6984.580925144508, 7041.92958070423, 7064.540804847668, 6660.367265109807, 6661.533692641662, 6676.365745254193, 6691.732330706717, 6711.530192886647, 6480.384363485461, 6531.0, 6600.867982640224, 6622.37087476689, 6629.900551491828, 6971.79084627462, 6976.302369762983, 6978.953157026283, 7013.403860671696, 7026.754063607954, 4528.682992190515, 4530.796114174804, 4571.542845715535, 4595.563421474954, 4605.907881842411, 6497.382748638872, 6655.667216639052, 6655.700493477708, 6664.266930637529, 6680.164979377578, 6457.418832305115, 6480.222373315232, 6513.1532900722605, 6518.837029074311, 6519.511036672174, 6461.256955450183, 6537.489132498561, 6544.116544266463, 6572.901406479003, 6584.9670751647855, 6521.9673901630185, 6546.934530654633, 6548.869022619426, 6552.27924928267, 6560.507961902781, 6384.265809431975, 6577.177852768404, 6582.3746744059235, 6597.1423714916755, 6600.8349791255605, 6319.146915166394, 6396.87401625958, 6401.967990160019, 6413.647249401328, 6415.486761059011], "value": 4900.115850282526, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [871.2333146830784, 876.8640860666596, 888.9511076890773, 894.2979760887705, 908.8500397434424, 13137.27744974026, 13573.389197486113, 16060.196990150504, 17317.567060823487, 17428.738568921475, 16773.83226167738, 17244.82755172448, 17568.385106521273, 18123.184456699448, 18265.45203643893, 964.7491652170451, 965.4207475514705, 965.7344230336679, 972.3388096094653, 1003.844404117363, 958.7698952251479, 962.5764663548016, 967.0619499085875, 974.9171320437771, 1023.9436830974294, 1086.7337502311946, 1086.8152414089584, 1089.831076183189, 1091.2034215022998, 1091.6179337231986, 1065.3714308557987, 1070.2668671959693, 1072.4744875011188, 1075.8171110911126, 1076.9084627806646, 782.1162086841889, 783.1972228465811, 787.6140691061339, 792.453207286976, 794.364508393283, 15973.520794376187, 16205.0, 16279.186040697918, 16304.184790760533, 16351.26419311134, 17899.0, 18429.170687319103, 18580.0, 18811.52971175718, 18964.051797410073, 14526.201058941753, 14554.781678274834, 14738.263086845614, 14892.436294189063, 14922.0, 3147.8740850365957, 3213.550102985584, 3216.662250463691, 3216.6783321667644, 3220.2915358621067, 87013.56493217494, 87093.56453217757, 88353.55823220906, 88500.5574972121, 89590.0, 12790.168639038433, 12930.224186548838, 12970.027247956441, 12976.870231297755, 13132.606021819362, 21727.891360543414, 21891.12435502594, 22144.0, 22158.335249942527, 22260.0, 7840.960795195988, 7911.248431399008, 7988.920110798934, 8048.919510804817, 8077.596120193967, 4088.509378874554, 4112.794360281974, 4128.752274863517, 4170.374443833389, 4182.372644103409, 3853.499045124116, 3876.9224615507533, 3893.0462036801164, 3915.138669492707, 3920.9607903921165, 937.840567103594, 942.4392486470539, 956.268454632207, 961.3895176562933, 966.5070813884829, 719.2268311565089, 727.1891840597696, 728.4354625165539, 731.579341878422, 763.9236076392427, 11865.466054027589, 12100.33448160342, 12445.626631200897, 13266.40301186449, 13328.800067998987, 719.9820004499929, 740.5926740292817, 744.118219909409, 749.2956620776453, 750.5121670913841, 5261.947380526146, 5379.569634429236, 5555.722213889289, 5559.72201389937, 5568.860778480571, 79252.6037369821, 80579.0, 80624.59687701524, 80650.5967470159, 81969.59015204886, 69514.00588932236, 71050.0, 72266.63866680634, 73001.88986770876, 73483.0, 62164.68917655383, 63218.36781632217, 63474.682626586575, 64715.35284647188, 64969.67515162394, 12281.0, 12979.0, 13166.802497962346, 13284.269365185008, 13302.46790128384, 34150.0, 35173.472397914564, 35510.644893550736, 35645.0, 36344.45483317699, 40700.59299406968, 41113.0, 41227.38158927678, 41663.166736665706, 42193.156136877704, 16778.58053548671, 17024.404145854834, 17501.912490437466, 17881.19534620919, 17922.462326130237, 19515.316963906196, 19859.900700496404, 19922.800771992093, 19996.90001549983, 20169.294074707315, 15998.12010339396, 16163.595910102342, 16545.172741363123, 18605.720914186568, 19035.333763318216, 16985.660286794442, 17200.13999300055, 17565.0, 17775.0, 18018.90990545039, 17413.82586174122, 17690.0, 17759.289628414717, 18182.363617273862, 18471.722924155878, 12516.436760345989, 12929.54746583865, 12969.184314196209, 13333.466661333827, 13759.931200343934, 13533.93233033868, 14828.184449855362, 14859.257037148316, 15004.474843380429, 15110.244487775348], "value": 8226.353620853657, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1511.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 111.0, 109.0, 109.0, 112.0, 110.0, 111.0, 110.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 117.0, 117.0, 172.0, 123.0, 118.0, 117.0, 119.0, 138.0, 123.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 165.0, 161.0, 163.0, 166.0, 165.0, 172.0, 168.0, 166.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 75.0, 96.0, 75.0, 75.0, 73.0, 74.0, 98.0, 74.0], "value": 78.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 114.0, 82.0, 83.0, 83.0, 94.0, 83.0, 82.0, 118.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 114.0, 113.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 150.0, 149.0, 147.0, 150.0, 149.0, 148.0, 149.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 100.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 48.0, 48.0, 48.0, 47.0, 47.0, 50.0, 51.0, 48.0, 51.0], "value": 48.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 55.0, 56.0, 55.0, 55.0, 56.0, 56.0, 55.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 82.0, 88.0, 81.0, 82.0, 82.0, 88.0, 82.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 128.0, 137.0, 125.0, 126.0, 127.0, 131.0, 128.0, 225.0, 131.0], "value": 139.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 184.0, 183.0, 189.0, 188.0, 190.0, 192.0, 184.0, 184.0, 185.0], "value": 185.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 69.0, 66.0, 68.0, 68.0, 66.0, 65.0, 64.0, 66.0], "value": 66.8, "unit": "score"}]}]} 04:12:12 INFO - Return code: 0 04:12:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:12:12 INFO - # TBPL SUCCESS # 04:12:12 INFO - Running post-action listener: _resource_record_post_action 04:12:12 INFO - [mozharness: 2017-05-06 11:12:12.623548Z] Finished run-tests step (success) 04:12:12 INFO - Running post-run listener: _resource_record_post_run 04:12:12 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 354975744; Read time: 180; Write time: 198880 04:12:12 INFO - TinderboxPrint: CPU usage
13.2% 04:12:12 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 180 04:12:12 INFO - TinderboxPrint: I/O write bytes / time
354,975,744 / 198,880 04:12:12 INFO - TinderboxPrint: CPU idle
8,248.5 (86.8%) 04:12:12 INFO - TinderboxPrint: CPU user
1,201.7 (12.6%) 04:12:12 INFO - TinderboxPrint: Swap in / out
0 / 0 04:12:12 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 30396416; Read time: 0; Write time: 7132 04:12:12 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 310374400; Read time: 168; Write time: 190052 04:12:13 INFO - Running post-run listener: _upload_blobber_files 04:12:13 INFO - Blob upload gear active. 04:12:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:12:13 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 04:12:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:12:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:12:13 INFO - (blobuploader) - INFO - Open directory for files ... 04:12:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:12:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:12:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:16 INFO - (blobuploader) - INFO - Done attempting. 04:12:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:12:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:12:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:17 INFO - (blobuploader) - INFO - Done attempting. 04:12:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:12:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:12:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:18 INFO - (blobuploader) - INFO - Done attempting. 04:12:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:12:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:12:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:19 INFO - (blobuploader) - INFO - Done attempting. 04:12:19 INFO - (blobuploader) - INFO - Iteration through files over. 04:12:19 INFO - Return code: 0 04:12:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:12:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:12:19 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/88cfc66723323579ce5cbde85b77b4ad5df5adbe771f9afd3eecac574665ebfca0260951dce59e08368a719dcf2f166e9a93986cf73e2b8adb9489dd4e1a0294", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a76ecbe092abd01ec9a149368ec9d0048b6b47f2a89f918facde50e8ad82eef610a0c637b6c1f2d6a1663742f00692160c70884c7719034f3a93c3a99c112dc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/adc07184ee805fb25f6494453b2aecc1820fde81f5877cb8d4b770d9a7be4abd576fb509f54a7a617e8008ccc6d3b4623853aef6b40c1c953b4a7fe1b57d2c93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/13640a64dbabd2e761f833c385f6167d1a2ada6b8fc224efedd4a623f9610110e01d71878067519c397029b42b812e7e5f29dafe84544d61d05e55c34278332a"} 04:12:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:12:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:12:19 INFO - Contents: 04:12:19 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/88cfc66723323579ce5cbde85b77b4ad5df5adbe771f9afd3eecac574665ebfca0260951dce59e08368a719dcf2f166e9a93986cf73e2b8adb9489dd4e1a0294", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a76ecbe092abd01ec9a149368ec9d0048b6b47f2a89f918facde50e8ad82eef610a0c637b6c1f2d6a1663742f00692160c70884c7719034f3a93c3a99c112dc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/adc07184ee805fb25f6494453b2aecc1820fde81f5877cb8d4b770d9a7be4abd576fb509f54a7a617e8008ccc6d3b4623853aef6b40c1c953b4a7fe1b57d2c93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/13640a64dbabd2e761f833c385f6167d1a2ada6b8fc224efedd4a623f9610110e01d71878067519c397029b42b812e7e5f29dafe84544d61d05e55c34278332a"} 04:12:19 INFO - Running post-run listener: copy_logs_to_upload_dir 04:12:19 INFO - Copying logs to upload dir... 04:12:19 INFO - mkdir: /builds/slave/test/build/upload/logs 04:12:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.674148 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-05-06 04:12:19.437734) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-06 04:12:19.446779) ========= 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=438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/88cfc66723323579ce5cbde85b77b4ad5df5adbe771f9afd3eecac574665ebfca0260951dce59e08368a719dcf2f166e9a93986cf73e2b8adb9489dd4e1a0294", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a76ecbe092abd01ec9a149368ec9d0048b6b47f2a89f918facde50e8ad82eef610a0c637b6c1f2d6a1663742f00692160c70884c7719034f3a93c3a99c112dc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/adc07184ee805fb25f6494453b2aecc1820fde81f5877cb8d4b770d9a7be4abd576fb509f54a7a617e8008ccc6d3b4623853aef6b40c1c953b4a7fe1b57d2c93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/13640a64dbabd2e761f833c385f6167d1a2ada6b8fc224efedd4a623f9610110e01d71878067519c397029b42b812e7e5f29dafe84544d61d05e55c34278332a"} build_url:https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011217 build_url: 'https://queue.taskcluster.net/v1/task/QPxxp6xHQ5a8axI1qoWtOQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/88cfc66723323579ce5cbde85b77b4ad5df5adbe771f9afd3eecac574665ebfca0260951dce59e08368a719dcf2f166e9a93986cf73e2b8adb9489dd4e1a0294", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a76ecbe092abd01ec9a149368ec9d0048b6b47f2a89f918facde50e8ad82eef610a0c637b6c1f2d6a1663742f00692160c70884c7719034f3a93c3a99c112dc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/adc07184ee805fb25f6494453b2aecc1820fde81f5877cb8d4b770d9a7be4abd576fb509f54a7a617e8008ccc6d3b4623853aef6b40c1c953b4a7fe1b57d2c93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/13640a64dbabd2e761f833c385f6167d1a2ada6b8fc224efedd4a623f9610110e01d71878067519c397029b42b812e7e5f29dafe84544d61d05e55c34278332a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-06 04:12:19.475328) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-06 04:12:19.475689) ========= 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=438111f3d31ce799eff2119d000001bc-1494066955.888368-1571381364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-06 04:12:19.557350) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-06 04:12:19.557659) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-06 04:12:19.557952) ========= ========= Total master_lag: 0.19 =========