builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-006 starttime: 1494279068.38 results: success (0) revision: bab7046ee2d82345d7d5b33b8ae4009c7e365176 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 14:31:08.385147) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 14:31:08.385567) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 14:31:08.385855) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 14:31:08.401924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 14:31:08.402195) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-08 14:31:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.7M=0s 2017-05-08 14:31:08 (24.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.167363 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 14:31:08.584284) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 14:31:08.584632) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016591 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 14:31:08.638353) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-08 14:31:08.638695) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bab7046ee2d82345d7d5b33b8ae4009c7e365176 --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 bab7046ee2d82345d7d5b33b8ae4009c7e365176 --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=e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-08 14:31:08,727 truncating revision to first 12 chars 2017-05-08 14:31:08,727 Setting DEBUG logging. 2017-05-08 14:31:08,727 attempt 1/10 2017-05-08 14:31:08,727 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bab7046ee2d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-08 14:31:09,979 unpacking tar archive at: mozilla-central-bab7046ee2d8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.563222 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-08 14:31:10.214132) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 14:31:10.214451) ========= script_repo_revision: bab7046ee2d82345d7d5b33b8ae4009c7e365176 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 14:31:10.219351) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 14:31:10.219637) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 14:31:10.235279) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-05-08 14:31:10.235644) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:31:10 INFO - MultiFileLogger online at 20170508 14:31:10 in /builds/slave/test 14:31:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:31:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:31:10 INFO - {'append_to_log': False, 14:31:10 INFO - 'base_work_dir': '/builds/slave/test', 14:31:10 INFO - 'blob_upload_branch': 'Firefox', 14:31:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:31:10 INFO - 'branch': 'Firefox', 14:31:10 INFO - 'buildbot_json_path': 'buildprops.json', 14:31:10 INFO - 'config_files': ('talos/linux_config.py',), 14:31:10 INFO - 'default_actions': ('clobber', 14:31:10 INFO - 'read-buildbot-config', 14:31:10 INFO - 'download-and-extract', 14:31:10 INFO - 'populate-webroot', 14:31:10 INFO - 'create-virtualenv', 14:31:10 INFO - 'install', 14:31:10 INFO - 'run-tests'), 14:31:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:31:10 INFO - 'download_minidump_stackwalk': True, 14:31:10 INFO - 'download_symbols': 'ondemand', 14:31:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:31:10 INFO - 'tooltool.py': '/tools/tooltool.py', 14:31:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:31:10 INFO - '/tools/misc-python/virtualenv.py')}, 14:31:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:31:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:31:10 INFO - 'gecko_profile': False, 14:31:10 INFO - 'gecko_profile_interval': 0, 14:31:10 INFO - 'installer_path': 'installer.exe', 14:31:10 INFO - 'log_level': 'info', 14:31:10 INFO - 'log_name': 'talos', 14:31:10 INFO - 'log_to_console': True, 14:31:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:31:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:31:10 INFO - 'opt_config_files': (), 14:31:10 INFO - 'pip_index': False, 14:31:10 INFO - 'suite': 'dromaeojs-e10s', 14:31:10 INFO - 'system_bits': '32', 14:31:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:31:10 INFO - 'title': 'talos-linux64-ix-006', 14:31:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:31:10 INFO - 'use_talos_json': True, 14:31:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:31:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:31:10 INFO - 'work_dir': 'build'} 14:31:10 INFO - [mozharness: 2017-05-08 21:31:10.518290Z] Running clobber step. 14:31:10 INFO - Running pre-action listener: _resource_record_pre_action 14:31:10 INFO - Running main action method: clobber 14:31:10 INFO - rmtree: /builds/slave/test/build 14:31:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:31:11 INFO - Running post-action listener: _resource_record_post_action 14:31:11 INFO - [mozharness: 2017-05-08 21:31:11.413746Z] Finished clobber step (success) 14:31:11 INFO - [mozharness: 2017-05-08 21:31:11.413846Z] Running read-buildbot-config step. 14:31:11 INFO - Running pre-action listener: _resource_record_pre_action 14:31:11 INFO - Running main action method: read_buildbot_config 14:31:11 INFO - Using buildbot properties: 14:31:11 INFO - { 14:31:11 INFO - "project": "", 14:31:11 INFO - "product": "firefox", 14:31:11 INFO - "who": "kwierso@gmail.com", 14:31:11 INFO - "installer_path": "public/build/target.tar.bz2", 14:31:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 14:31:11 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 14:31:11 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 14:31:11 INFO - "stage_platform": "linux64-stylo", 14:31:11 INFO - "basedir": "/builds/slave/test", 14:31:11 INFO - "buildnumber": 83, 14:31:11 INFO - "platform": "ubuntu64_hw_stylo", 14:31:11 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:31:11 INFO - "slavebuilddir": "test", 14:31:11 INFO - "taskId": "bnCGyAdaQJ-tMXcAG3iP7g", 14:31:11 INFO - "branch": "mozilla-central", 14:31:11 INFO - "script_repo_revision": "production", 14:31:11 INFO - "revision": "bab7046ee2d82345d7d5b33b8ae4009c7e365176", 14:31:11 INFO - "slavename": "talos-linux64-ix-006", 14:31:11 INFO - "repo_path": "mozilla-central" 14:31:11 INFO - } 14:31:11 INFO - Finding installer, test and symbols from parent task. 14:31:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bnCGyAdaQJ-tMXcAG3iP7g'}, attempt #1 14:31:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bnCGyAdaQJ-tMXcAG3iP7g'}, attempt #1 14:31:12 INFO - Task dependencies: FwB1HLWIQt6yclQF3vLb-A 14:31:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A'}, attempt #1 14:31:12 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.tar.bz2 14:31:12 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/test_packages.json 14:31:12 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.crashreporter-symbols.zip 14:31:12 INFO - Running post-action listener: _resource_record_post_action 14:31:12 INFO - [mozharness: 2017-05-08 21:31:12.780277Z] Finished read-buildbot-config step (success) 14:31:12 INFO - [mozharness: 2017-05-08 21:31:12.780493Z] Running download-and-extract step. 14:31:12 INFO - Running pre-action listener: _resource_record_pre_action 14:31:12 INFO - Running main action method: download_and_extract 14:31:12 INFO - mkdir: /builds/slave/test/build/tests 14:31:12 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')]} 14:31:12 INFO - trying https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.test_packages.json 14:31:12 INFO - Downloading https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:31:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:31:13 INFO - Downloaded 986 bytes. 14:31:13 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:31:13 INFO - Using the following test package requirements: 14:31:13 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:31:13 INFO - u'common': [u'target.common.tests.zip'], 14:31:13 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:31:13 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:31:13 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:31:13 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:31:13 INFO - u'mozbase': [u'target.common.tests.zip'], 14:31:13 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:31:13 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:31:13 INFO - u'web-platform': [u'target.common.tests.zip', 14:31:13 INFO - u'target.web-platform.tests.zip'], 14:31:13 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:31:13 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:31:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.common.tests.zip 14:31:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:31:13 INFO - Fetch https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.common.tests.zip into memory 14:31:14 INFO - Content-Length response header: 58446209 14:31:14 INFO - Bytes received: 58446209 14:31:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:31:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.common.tests.zip 14:31:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:31:24 INFO - Fetch https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.common.tests.zip into memory 14:31:25 INFO - Content-Length response header: 58446209 14:31:25 INFO - Bytes received: 58446209 14:31:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.talos.tests.zip 14:31:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:31:36 INFO - Fetch https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.talos.tests.zip into memory 14:31:37 INFO - Content-Length response header: 14409362 14:31:37 INFO - Bytes received: 14409362 14:31: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')]} 14:31:37 INFO - trying https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.tar.bz2 14:31:37 INFO - Downloading https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:31:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:31:39 INFO - Downloaded 59930022 bytes. 14:31:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.tar.bz2 14:31:39 INFO - mkdir: /builds/slave/test/properties 14:31:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:31:39 INFO - Writing to file /builds/slave/test/properties/build_url 14:31:39 INFO - Contents: 14:31:39 INFO - build_url:https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.tar.bz2 14:31:39 INFO - Running post-action listener: _resource_record_post_action 14:31:39 INFO - Running post-action listener: set_extra_try_arguments 14:31:39 INFO - [mozharness: 2017-05-08 21:31:39.086998Z] Finished download-and-extract step (success) 14:31:39 INFO - [mozharness: 2017-05-08 21:31:39.087095Z] Running populate-webroot step. 14:31:39 INFO - Running pre-action listener: _resource_record_pre_action 14:31:39 INFO - Running main action method: populate_webroot 14:31:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:31:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:31:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:31:39 INFO - '--tppagecycles', 14:31:39 INFO - '7'], 14:31:39 INFO - 'tests': ['tsvgm']}}, 14:31:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:31:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:31:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:31:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:31:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:31:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:31:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:31:39 INFO - 'talos_options': ['--disable-e10s'], 14:31:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:31:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:31:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:31:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:31:39 INFO - 'talos_options': ['--disable-e10s'], 14:31:39 INFO - 'tests': ['damp', 'tps']}, 14:31:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:31:39 INFO - 'tests': ['damp', 'tps']}, 14:31:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:31:39 INFO - 'tests': ['dromaeo_dom']}, 14:31:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:31:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:31:39 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 14:31:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:31:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:31:39 INFO - 'tests': ['a11yr', 14:31:39 INFO - 'ts_paint', 14:31:39 INFO - 'tpaint', 14:31:39 INFO - 'sessionrestore', 14:31:39 INFO - 'sessionrestore_no_auto_restore', 14:31:39 INFO - 'tabpaint']}, 14:31:39 INFO - 'other-e10s': {'tests': ['a11yr', 14:31:39 INFO - 'ts_paint', 14:31:39 INFO - 'tpaint', 14:31:39 INFO - 'sessionrestore', 14:31:39 INFO - 'sessionrestore_no_auto_restore', 14:31:39 INFO - 'tabpaint']}, 14:31:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:31:39 INFO - 'ts_paint', 14:31:39 INFO - 'tpaint', 14:31:39 INFO - 'sessionrestore', 14:31:39 INFO - 'sessionrestore_no_auto_restore', 14:31:39 INFO - 'tabpaint']}, 14:31:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:31:39 INFO - 'ts_paint', 14:31:39 INFO - 'tpaint', 14:31:39 INFO - 'sessionrestore', 14:31:39 INFO - 'sessionrestore_no_auto_restore', 14:31:39 INFO - 'tabpaint']}, 14:31:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:31:39 INFO - 'tests': ['a11yr', 14:31:39 INFO - 'ts_paint', 14:31:39 INFO - 'tpaint', 14:31:39 INFO - 'sessionrestore', 14:31:39 INFO - 'sessionrestore_no_auto_restore', 14:31:39 INFO - 'tabpaint']}, 14:31:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:31:39 INFO - 'tests': ['a11yr', 14:31:39 INFO - 'ts_paint', 14:31:39 INFO - 'tpaint', 14:31:39 INFO - 'sessionrestore', 14:31:39 INFO - 'sessionrestore_no_auto_restore', 14:31:39 INFO - 'tabpaint']}, 14:31:39 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 14:31:39 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 14:31:39 INFO - 'bloom_basic_ref']}, 14:31:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:31:39 INFO - 'tests': ['tsvgx', 14:31:39 INFO - 'tsvgr_opacity', 14:31:39 INFO - 'tart', 14:31:39 INFO - 'tscrollx', 14:31:39 INFO - 'cart', 14:31:39 INFO - 'tsvg_static']}, 14:31:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:31:39 INFO - 'tsvgr_opacity', 14:31:39 INFO - 'tart', 14:31:39 INFO - 'tscrollx', 14:31:39 INFO - 'cart', 14:31:39 INFO - 'tsvg_static']}, 14:31:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:31:39 INFO - 'talos_options': ['--disable-e10s'], 14:31:39 INFO - 'tests': ['tp5o']}, 14:31:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:31:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:31:39 INFO - 'talos_options': ['--disable-e10s', 14:31:39 INFO - '--xperf_path', 14:31:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:31:39 INFO - 'tests': ['tp5n']}, 14:31:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:31:39 INFO - 'talos_options': ['--xperf_path', 14:31:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:31:39 INFO - 'tests': ['tp5n']}}, 14:31:39 INFO - 'talos.zip': {'path': '', 14:31:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:31:39 INFO - Running post-action listener: _resource_record_post_action 14:31:39 INFO - [mozharness: 2017-05-08 21:31:39.103885Z] Finished populate-webroot step (success) 14:31:39 INFO - [mozharness: 2017-05-08 21:31:39.103973Z] Running create-virtualenv step. 14:31:39 INFO - Running pre-action listener: _resource_record_pre_action 14:31:39 INFO - Running main action method: create_virtualenv 14:31:39 INFO - Creating virtualenv /builds/slave/test/build/venv 14:31:39 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 14:31:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:31:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:31:39 INFO - Using real prefix '/usr' 14:31:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:31:40 INFO - Installing distribute.............................................................................................................................................................................................done. 14:31:42 INFO - Installing pip.................done. 14:31:42 INFO - Return code: 0 14:31:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:31:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:31:43 INFO - Reading from file tmpfile_stdout 14:31:43 INFO - Output received: 14:31:43 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) 14:31:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:31:43 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')]} 14:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:43 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')]} 14:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:43 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 0x19ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ba30>, '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 0x1d1c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1cca0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321', '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 14:31:43 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 14:31:43 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 14:31:43 INFO - Using env: {'DISPLAY': ':0', 14:31:43 INFO - 'HOME': '/home/cltbld', 14:31:43 INFO - 'LANG': 'en_US.UTF-8', 14:31:43 INFO - 'LANGUAGE': 'en_US:en', 14:31:43 INFO - 'LOGNAME': 'cltbld', 14:31:43 INFO - 'MAIL': '/var/mail/cltbld', 14:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:43 INFO - 'MOZ_NO_REMOTE': '1', 14:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:43 INFO - 'NO_EM_RESTART': '1', 14:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:43 INFO - 'PWD': '/builds/slave/test', 14:31:43 INFO - 'SHELL': '/bin/bash', 14:31:43 INFO - 'SHLVL': '1', 14:31:43 INFO - 'TERM': 'linux', 14:31:43 INFO - 'TMOUT': '86400', 14:31:43 INFO - 'USER': 'cltbld', 14:31:43 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321', 14:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:43 INFO - '_': '/tools/buildbot/bin/python'} 14:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:43 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 14:31:43 INFO - Cleaning up... 14:31:43 INFO - Return code: 0 14:31:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:31:43 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')]} 14:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:43 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')]} 14:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:43 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 0x19ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ba30>, '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 0x1d1c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1cca0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321', '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 14:31:43 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 14:31:43 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 14:31:43 INFO - Using env: {'DISPLAY': ':0', 14:31:43 INFO - 'HOME': '/home/cltbld', 14:31:43 INFO - 'LANG': 'en_US.UTF-8', 14:31:43 INFO - 'LANGUAGE': 'en_US:en', 14:31:43 INFO - 'LOGNAME': 'cltbld', 14:31:43 INFO - 'MAIL': '/var/mail/cltbld', 14:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:43 INFO - 'MOZ_NO_REMOTE': '1', 14:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:43 INFO - 'NO_EM_RESTART': '1', 14:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:43 INFO - 'PWD': '/builds/slave/test', 14:31:43 INFO - 'SHELL': '/bin/bash', 14:31:43 INFO - 'SHLVL': '1', 14:31:43 INFO - 'TERM': 'linux', 14:31:43 INFO - 'TMOUT': '86400', 14:31:43 INFO - 'USER': 'cltbld', 14:31:43 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321', 14:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:43 INFO - '_': '/tools/buildbot/bin/python'} 14:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:43 INFO - Downloading/unpacking psutil>=3.1.1 14:31:43 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 14:31:43 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 14:31:43 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 14:31:43 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 14:31:43 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 14:31:43 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 14:31:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:31:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:31:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:31:44 INFO - Installing collected packages: psutil 14:31:44 INFO - Running setup.py install for psutil 14:31:44 INFO - building 'psutil._psutil_linux' extension 14:31:44 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 14:31:46 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 14:31:46 INFO - building 'psutil._psutil_posix' extension 14:31:46 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 14:31:46 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 14:31:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:31:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:31:46 INFO - Successfully installed psutil 14:31:46 INFO - Cleaning up... 14:31:46 INFO - Return code: 0 14:31:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:46 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 0x19ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ba30>, '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 0x1d1c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1cca0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321', '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 14:31:46 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 14:31:46 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 14:31:46 INFO - Using env: {'DISPLAY': ':0', 14:31:46 INFO - 'HOME': '/home/cltbld', 14:31:46 INFO - 'LANG': 'en_US.UTF-8', 14:31:46 INFO - 'LANGUAGE': 'en_US:en', 14:31:46 INFO - 'LOGNAME': 'cltbld', 14:31:46 INFO - 'MAIL': '/var/mail/cltbld', 14:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:46 INFO - 'MOZ_NO_REMOTE': '1', 14:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:46 INFO - 'NO_EM_RESTART': '1', 14:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:46 INFO - 'PWD': '/builds/slave/test', 14:31:46 INFO - 'SHELL': '/bin/bash', 14:31:46 INFO - 'SHLVL': '1', 14:31:46 INFO - 'TERM': 'linux', 14:31:46 INFO - 'TMOUT': '86400', 14:31:46 INFO - 'USER': 'cltbld', 14:31:46 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321', 14:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:46 INFO - '_': '/tools/buildbot/bin/python'} 14:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:31:46 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 14:31:46 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 14:31:46 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 14:31:46 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 14:31:46 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 14:31:46 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 14:31:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:31:47 INFO - Installing collected packages: mozsystemmonitor 14:31:47 INFO - Running setup.py install for mozsystemmonitor 14:31:48 INFO - Successfully installed mozsystemmonitor 14:31:48 INFO - Cleaning up... 14:31:48 INFO - Return code: 0 14:31:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:31:48 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')]} 14:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:48 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')]} 14:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:48 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 0x19ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ba30>, '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 0x1d1c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1cca0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321', '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 14:31:48 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 14:31:48 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 14:31:48 INFO - Using env: {'DISPLAY': ':0', 14:31:48 INFO - 'HOME': '/home/cltbld', 14:31:48 INFO - 'LANG': 'en_US.UTF-8', 14:31:48 INFO - 'LANGUAGE': 'en_US:en', 14:31:48 INFO - 'LOGNAME': 'cltbld', 14:31:48 INFO - 'MAIL': '/var/mail/cltbld', 14:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:48 INFO - 'MOZ_NO_REMOTE': '1', 14:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:48 INFO - 'NO_EM_RESTART': '1', 14:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:48 INFO - 'PWD': '/builds/slave/test', 14:31:48 INFO - 'SHELL': '/bin/bash', 14:31:48 INFO - 'SHLVL': '1', 14:31:48 INFO - 'TERM': 'linux', 14:31:48 INFO - 'TMOUT': '86400', 14:31:48 INFO - 'USER': 'cltbld', 14:31:48 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321', 14:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:48 INFO - '_': '/tools/buildbot/bin/python'} 14:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:48 INFO - Downloading/unpacking jsonschema==2.5.1 14:31:48 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 14:31:48 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 14:31:48 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 14:31:48 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 14:31:48 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 14:31:48 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 14:31:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:31:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:31:49 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 14:31:49 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 14:31:49 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 14:31:49 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 14:31:49 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 14:31:49 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 14:31:49 INFO - Downloading functools32-3.2.3-2.tar.gz 14:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:31:49 INFO - warning: no files found matching '*.txt' 14:31:49 INFO - no previously-included directories found matching 'build' 14:31:49 INFO - no previously-included directories found matching 'dist' 14:31:49 INFO - no previously-included directories found matching '.git*' 14:31:49 INFO - Installing collected packages: jsonschema, functools32 14:31:49 INFO - Running setup.py install for functools32 14:31:49 INFO - warning: no files found matching '*.txt' 14:31:49 INFO - no previously-included directories found matching 'build' 14:31:49 INFO - no previously-included directories found matching 'dist' 14:31:49 INFO - no previously-included directories found matching '.git*' 14:31:49 INFO - Successfully installed jsonschema functools32 14:31:49 INFO - Cleaning up... 14:31:49 INFO - Return code: 0 14:31:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:31:49 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')]} 14:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:49 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')]} 14:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:49 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 0x19ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ba30>, '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 0x1d1c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1cca0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321', '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 14:31:49 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 14:31:49 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 14:31:49 INFO - Using env: {'DISPLAY': ':0', 14:31:49 INFO - 'HOME': '/home/cltbld', 14:31:49 INFO - 'LANG': 'en_US.UTF-8', 14:31:49 INFO - 'LANGUAGE': 'en_US:en', 14:31:49 INFO - 'LOGNAME': 'cltbld', 14:31:49 INFO - 'MAIL': '/var/mail/cltbld', 14:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:49 INFO - 'MOZ_NO_REMOTE': '1', 14:31:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:49 INFO - 'NO_EM_RESTART': '1', 14:31:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:49 INFO - 'PWD': '/builds/slave/test', 14:31:49 INFO - 'SHELL': '/bin/bash', 14:31:49 INFO - 'SHLVL': '1', 14:31:49 INFO - 'TERM': 'linux', 14:31:49 INFO - 'TMOUT': '86400', 14:31:49 INFO - 'USER': 'cltbld', 14:31:49 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321', 14:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:49 INFO - '_': '/tools/buildbot/bin/python'} 14:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:31:50 INFO - Cleaning up... 14:31:50 INFO - Return code: 0 14:31:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:31:50 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')]} 14:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:50 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')]} 14:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:50 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 0x19ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ba30>, '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 0x1d1c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1cca0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321', '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 14:31:50 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 14:31:50 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 14:31:50 INFO - Using env: {'DISPLAY': ':0', 14:31:50 INFO - 'HOME': '/home/cltbld', 14:31:50 INFO - 'LANG': 'en_US.UTF-8', 14:31:50 INFO - 'LANGUAGE': 'en_US:en', 14:31:50 INFO - 'LOGNAME': 'cltbld', 14:31:50 INFO - 'MAIL': '/var/mail/cltbld', 14:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:50 INFO - 'MOZ_NO_REMOTE': '1', 14:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:50 INFO - 'NO_EM_RESTART': '1', 14:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:50 INFO - 'PWD': '/builds/slave/test', 14:31:50 INFO - 'SHELL': '/bin/bash', 14:31:50 INFO - 'SHLVL': '1', 14:31:50 INFO - 'TERM': 'linux', 14:31:50 INFO - 'TMOUT': '86400', 14:31:50 INFO - 'USER': 'cltbld', 14:31:50 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321', 14:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:50 INFO - '_': '/tools/buildbot/bin/python'} 14:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:50 INFO - Downloading/unpacking blobuploader==1.2.4 14:31:50 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 14:31:50 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 14:31:50 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 14:31:50 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 14:31:50 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 14:31:50 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 14:31:51 INFO - Downloading blobuploader-1.2.4.tar.gz 14:31:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:31:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:31:51 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 14:31:51 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 14:31:51 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 14:31:51 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 14:31:51 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 14:31:51 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 14:31:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:31:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:52 INFO - Downloading docopt-0.6.1.tar.gz 14:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:31:52 INFO - Installing collected packages: blobuploader, requests, docopt 14:31:52 INFO - Running setup.py install for blobuploader 14:31:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:31:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:31:52 INFO - Running setup.py install for requests 14:31:52 INFO - Running setup.py install for docopt 14:31:52 INFO - Successfully installed blobuploader requests docopt 14:31:52 INFO - Cleaning up... 14:31:52 INFO - Return code: 0 14:31:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31:52 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')]} 14:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:52 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')]} 14:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:52 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 0x19ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ba30>, '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 0x1d1c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1cca0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321', '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 14:31:52 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 14:31:52 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 14:31:52 INFO - Using env: {'DISPLAY': ':0', 14:31:52 INFO - 'HOME': '/home/cltbld', 14:31:52 INFO - 'LANG': 'en_US.UTF-8', 14:31:52 INFO - 'LANGUAGE': 'en_US:en', 14:31:52 INFO - 'LOGNAME': 'cltbld', 14:31:52 INFO - 'MAIL': '/var/mail/cltbld', 14:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:52 INFO - 'MOZ_NO_REMOTE': '1', 14:31:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:52 INFO - 'NO_EM_RESTART': '1', 14:31:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:52 INFO - 'PWD': '/builds/slave/test', 14:31:52 INFO - 'SHELL': '/bin/bash', 14:31:52 INFO - 'SHLVL': '1', 14:31:52 INFO - 'TERM': 'linux', 14:31:52 INFO - 'TMOUT': '86400', 14:31:52 INFO - 'USER': 'cltbld', 14:31:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321', 14:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:52 INFO - '_': '/tools/buildbot/bin/python'} 14:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:31:53 INFO - Running setup.py (path:/tmp/pip-9XOjS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:31:53 INFO - Running setup.py (path:/tmp/pip-c_2JbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:31:53 INFO - Running setup.py (path:/tmp/pip-hZ2_gX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:31:53 INFO - Running setup.py (path:/tmp/pip-Q3NsDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:31:53 INFO - Running setup.py (path:/tmp/pip-oCQmch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:31:53 INFO - Running setup.py (path:/tmp/pip-2w_XQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:31:53 INFO - Running setup.py (path:/tmp/pip-LD0QkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:31:53 INFO - Running setup.py (path:/tmp/pip-ew9pr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:31:53 INFO - Running setup.py (path:/tmp/pip-LCCIVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:31:53 INFO - Running setup.py (path:/tmp/pip-B02yp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:31:53 INFO - Running setup.py (path:/tmp/pip-iCXrxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:31:53 INFO - Running setup.py (path:/tmp/pip-yvVg1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:31:53 INFO - Running setup.py (path:/tmp/pip-kTBBb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:31:53 INFO - Running setup.py (path:/tmp/pip-7LOIB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:54 INFO - Running setup.py (path:/tmp/pip-uC3_dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:31:54 INFO - Running setup.py (path:/tmp/pip-ObbX2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:31:54 INFO - Running setup.py (path:/tmp/pip-ob2QOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:31:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:31:54 INFO - Running setup.py install for manifestparser 14:31:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:31:54 INFO - Running setup.py install for mozcrash 14:31:54 INFO - Running setup.py install for mozdebug 14:31:54 INFO - Running setup.py install for mozdevice 14:31:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:31:54 INFO - Running setup.py install for mozfile 14:31:54 INFO - Running setup.py install for mozhttpd 14:31:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:31:54 INFO - Running setup.py install for mozinfo 14:31:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:31:54 INFO - Running setup.py install for mozInstall 14:31:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:31:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:31:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:31:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:31:55 INFO - Running setup.py install for mozleak 14:31:55 INFO - Running setup.py install for mozlog 14:31:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:31:55 INFO - Running setup.py install for moznetwork 14:31:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:31:55 INFO - Running setup.py install for mozprocess 14:31:55 INFO - Running setup.py install for mozprofile 14:31:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:31:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:31:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:31:55 INFO - Running setup.py install for mozrunner 14:31:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:31:55 INFO - Running setup.py install for mozscreenshot 14:31:55 INFO - Running setup.py install for moztest 14:31:55 INFO - Running setup.py install for mozversion 14:31:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:31:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:31:56 INFO - Cleaning up... 14:31:56 INFO - Return code: 0 14:31:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31:56 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')]} 14:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:56 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')]} 14:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:56 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 0x19ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ba30>, '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 0x1d1c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1cca0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321', '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 14:31:56 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 14:31:56 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 14:31:56 INFO - Using env: {'DISPLAY': ':0', 14:31:56 INFO - 'HOME': '/home/cltbld', 14:31:56 INFO - 'LANG': 'en_US.UTF-8', 14:31:56 INFO - 'LANGUAGE': 'en_US:en', 14:31:56 INFO - 'LOGNAME': 'cltbld', 14:31:56 INFO - 'MAIL': '/var/mail/cltbld', 14:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:56 INFO - 'MOZ_NO_REMOTE': '1', 14:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:56 INFO - 'NO_EM_RESTART': '1', 14:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:56 INFO - 'PWD': '/builds/slave/test', 14:31:56 INFO - 'SHELL': '/bin/bash', 14:31:56 INFO - 'SHLVL': '1', 14:31:56 INFO - 'TERM': 'linux', 14:31:56 INFO - 'TMOUT': '86400', 14:31:56 INFO - 'USER': 'cltbld', 14:31:56 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321', 14:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:56 INFO - '_': '/tools/buildbot/bin/python'} 14:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:31:56 INFO - Running setup.py (path:/tmp/pip-97Brn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:31:56 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)) 14:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:31:56 INFO - Running setup.py (path:/tmp/pip-AuDU6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:31:56 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)) 14:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:31:56 INFO - Running setup.py (path:/tmp/pip-jQOLSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:31:56 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)) 14:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:31:56 INFO - Running setup.py (path:/tmp/pip-2O3HqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:31:56 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)) 14:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:31:56 INFO - Running setup.py (path:/tmp/pip-M6relp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:31:56 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)) 14:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:31:56 INFO - Running setup.py (path:/tmp/pip-Ea7ZjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:31:56 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)) 14:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:31:56 INFO - Running setup.py (path:/tmp/pip-RjizdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:31:56 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)) 14:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:31:56 INFO - Running setup.py (path:/tmp/pip-CzBcxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:31:56 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)) 14:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:31:56 INFO - Running setup.py (path:/tmp/pip-lGsoEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:31:56 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)) 14:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:31:56 INFO - Running setup.py (path:/tmp/pip-XJx2fV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:31:56 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)) 14:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:31:56 INFO - Running setup.py (path:/tmp/pip-IVbePH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:31:57 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)) 14:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:31:57 INFO - Running setup.py (path:/tmp/pip-U9RhXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:31:57 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)) 14:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:31:57 INFO - Running setup.py (path:/tmp/pip-UYF9Qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:31:57 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)) 14:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:31:57 INFO - Running setup.py (path:/tmp/pip-ojBQFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:31:57 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)) 14:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:57 INFO - Running setup.py (path:/tmp/pip-jWP5sS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:57 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)) 14:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:31:57 INFO - Running setup.py (path:/tmp/pip-NjR66k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:31:57 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)) 14:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:31:57 INFO - Running setup.py (path:/tmp/pip-EyGCDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:31:57 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)) 14:31:57 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)) 14:31:57 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)) 14:31:57 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)) 14:31:57 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)) 14:31:57 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)) 14:31:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:58 INFO - Downloading blessings-1.6.tar.gz 14:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:31:58 INFO - Installing collected packages: blessings 14:31:58 INFO - Running setup.py install for blessings 14:31:58 INFO - Successfully installed blessings 14:31:58 INFO - Cleaning up... 14:31:58 INFO - Return code: 0 14:31:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:31:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:31:59 INFO - Reading from file tmpfile_stdout 14:31:59 INFO - Current package versions: 14:31:59 INFO - argparse == 1.2.1 14:31:59 INFO - blessings == 1.6 14:31:59 INFO - blobuploader == 1.2.4 14:31:59 INFO - docopt == 0.6.1 14:31:59 INFO - functools32 == 3.2.3-2 14:31:59 INFO - jsonschema == 2.5.1 14:31:59 INFO - manifestparser == 1.1 14:31:59 INFO - mozInstall == 1.12 14:31:59 INFO - mozcrash == 1.0 14:31:59 INFO - mozdebug == 0.1 14:31:59 INFO - mozdevice == 0.50 14:31:59 INFO - mozfile == 1.2 14:31:59 INFO - mozhttpd == 0.7 14:31:59 INFO - mozinfo == 0.9 14:31:59 INFO - mozleak == 0.1 14:31:59 INFO - mozlog == 3.4 14:31:59 INFO - moznetwork == 0.27 14:31:59 INFO - mozprocess == 0.25 14:31:59 INFO - mozprofile == 0.28 14:31:59 INFO - mozrunner == 6.13 14:31:59 INFO - mozscreenshot == 0.1 14:31:59 INFO - mozsystemmonitor == 0.3 14:31:59 INFO - moztest == 0.8 14:31:59 INFO - mozversion == 1.4 14:31:59 INFO - psutil == 3.1.1 14:31:59 INFO - requests == 1.2.3 14:31:59 INFO - wsgiref == 0.1.2 14:31:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:59 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 0x19ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ba30>, '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 0x1d1c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1cca0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321', '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 14:31:59 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 14:31:59 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 14:31:59 INFO - Using env: {'DISPLAY': ':0', 14:31:59 INFO - 'HOME': '/home/cltbld', 14:31:59 INFO - 'LANG': 'en_US.UTF-8', 14:31:59 INFO - 'LANGUAGE': 'en_US:en', 14:31:59 INFO - 'LOGNAME': 'cltbld', 14:31:59 INFO - 'MAIL': '/var/mail/cltbld', 14:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:59 INFO - 'MOZ_NO_REMOTE': '1', 14:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:59 INFO - 'NO_EM_RESTART': '1', 14:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:59 INFO - 'PWD': '/builds/slave/test', 14:31:59 INFO - 'SHELL': '/bin/bash', 14:31:59 INFO - 'SHLVL': '1', 14:31:59 INFO - 'TERM': 'linux', 14:31:59 INFO - 'TMOUT': '86400', 14:31:59 INFO - 'USER': 'cltbld', 14:31:59 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321', 14:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:59 INFO - '_': '/tools/buildbot/bin/python'} 14:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:59 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)) 14:31:59 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)) 14:31:59 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)) 14:31:59 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)) 14:31:59 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)) 14:31:59 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)) 14:31:59 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)) 14:31:59 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)) 14:31:59 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)) 14:31:59 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)) 14:31:59 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)) 14:31:59 INFO - Cleaning up... 14:31:59 INFO - Return code: 0 14:31:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b78a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ba30>, '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 0x1d1c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1cca0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321', '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 14:31:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:31:59 INFO - Using env: {'DISPLAY': ':0', 14:31:59 INFO - 'HOME': '/home/cltbld', 14:31:59 INFO - 'LANG': 'en_US.UTF-8', 14:31:59 INFO - 'LANGUAGE': 'en_US:en', 14:31:59 INFO - 'LOGNAME': 'cltbld', 14:31:59 INFO - 'MAIL': '/var/mail/cltbld', 14:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:59 INFO - 'MOZ_NO_REMOTE': '1', 14:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:59 INFO - 'NO_EM_RESTART': '1', 14:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:59 INFO - 'PWD': '/builds/slave/test', 14:31:59 INFO - 'SHELL': '/bin/bash', 14:31:59 INFO - 'SHLVL': '1', 14:31:59 INFO - 'TERM': 'linux', 14:31:59 INFO - 'TMOUT': '86400', 14:31:59 INFO - 'USER': 'cltbld', 14:31:59 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321', 14:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:59 INFO - '_': '/tools/buildbot/bin/python'} 14:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:31:59 INFO - Cleaning up... 14:31:59 INFO - Return code: 0 14:31:59 INFO - Running post-action listener: _resource_record_post_action 14:31:59 INFO - Running post-action listener: _start_resource_monitoring 14:31:59 INFO - Starting resource monitoring. 14:31:59 INFO - [mozharness: 2017-05-08 21:31:59.621621Z] Finished create-virtualenv step (success) 14:31:59 INFO - [mozharness: 2017-05-08 21:31:59.622159Z] Running install step. 14:31:59 INFO - Running pre-action listener: _resource_record_pre_action 14:31:59 INFO - Running main action method: install 14:31:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:31:59 INFO - Reading from file tmpfile_stdout 14:31:59 INFO - Detecting whether we're running mozinstall >=1.0... 14:31:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:31:59 INFO - Reading from file tmpfile_stdout 14:31:59 INFO - Output received: 14:31:59 INFO - Usage: mozinstall [options] installer 14:31:59 INFO - Options: 14:31:59 INFO - -h, --help show this help message and exit 14:31:59 INFO - -d DEST, --destination=DEST 14:31:59 INFO - Directory to install application into. [default: 14:31:59 INFO - "/builds/slave/test"] 14:31:59 INFO - --app=APP Application being installed. [default: firefox] 14:31:59 INFO - mkdir: /builds/slave/test/build/application 14:31:59 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'] 14:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:32:15 INFO - Reading from file tmpfile_stdout 14:32:15 INFO - Output received: 14:32:15 INFO - /builds/slave/test/build/application/firefox/firefox 14:32:15 INFO - Running post-action listener: _resource_record_post_action 14:32:15 INFO - [mozharness: 2017-05-08 21:32:15.315644Z] Finished install step (success) 14:32:15 INFO - [mozharness: 2017-05-08 21:32:15.315919Z] Running run-tests step. 14:32:15 INFO - Running pre-action listener: _resource_record_pre_action 14:32:15 INFO - Running main action method: run_tests 14:32:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:32:15 INFO - Python 2.7.3 14:32:15 INFO - Return code: 0 14:32:15 INFO - grabbing minidump binary from tooltool 14:32:15 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')]} 14:32:15 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 0x1d1ba30>, '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 0x1d1c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d1cca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:32:15 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 14:32:15 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 14:32:15 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 14:32:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:32:15 INFO - Return code: 0 14:32:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:32:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:32:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:32:15 INFO - ENV: RUST_BACKTRACE is now 1 14:32:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:32:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:32:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 14:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 14:32:15 INFO - Using env: {'DISPLAY': ':0', 14:32:15 INFO - 'HOME': '/home/cltbld', 14:32:15 INFO - 'LANG': 'en_US.UTF-8', 14:32:15 INFO - 'LANGUAGE': 'en_US:en', 14:32:15 INFO - 'LOGNAME': 'cltbld', 14:32:15 INFO - 'MAIL': '/var/mail/cltbld', 14:32:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:32:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:15 INFO - 'MOZ_NO_REMOTE': '1', 14:32:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:32:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:15 INFO - 'NO_EM_RESTART': '1', 14:32:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:15 INFO - 'PWD': '/builds/slave/test', 14:32:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:32:15 INFO - 'RUST_BACKTRACE': '1', 14:32:15 INFO - 'SHELL': '/bin/bash', 14:32:15 INFO - 'SHLVL': '1', 14:32:15 INFO - 'TERM': 'linux', 14:32:15 INFO - 'TMOUT': '86400', 14:32:15 INFO - 'USER': 'cltbld', 14:32:15 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321', 14:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:15 INFO - '_': '/tools/buildbot/bin/python'} 14:32:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 14:32:15 INFO - mozversion application_buildid: 20170508203447 14:32:15 INFO - mozversion application_changeset: bab7046ee2d82345d7d5b33b8ae4009c7e365176 14:32:15 INFO - mozversion application_display_name: Nightly 14:32:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:32:15 INFO - mozversion application_name: Firefox 14:32:15 INFO - mozversion application_remotingname: firefox 14:32:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:32:15 INFO - mozversion application_vendor: Mozilla 14:32:15 INFO - mozversion application_version: 55.0a1 14:32:15 INFO - mozversion platform_buildid: 20170508203447 14:32:15 INFO - mozversion platform_changeset: bab7046ee2d82345d7d5b33b8ae4009c7e365176 14:32:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:32:15 INFO - mozversion platform_version: 55.0a1 14:32:15 INFO - using testdate: 1494279135 14:32:15 INFO - actual date: 1494279135 14:32:15 INFO - starting webserver on 'localhost:60270' 14:32:15 INFO - SUITE-START | Running 2 tests 14:32:15 INFO - TEST-START | dromaeo_css 14:32:15 INFO - operating with platform_type : linux_ 14:32:15 INFO - Initialising browser for dromaeo_css test... 14:32:15 INFO - TEST-INFO | started process 3318 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps_OO4k/profile http://localhost:60270/getInfo.html) 14:32:20 INFO - PID 3318 | __metrics Screen width/height:1600/1200 14:32:20 INFO - PID 3318 | colorDepth:24 14:32:20 INFO - PID 3318 | Browser inner width/height: 1024/695 14:32:20 INFO - PID 3318 | __metrics 14:32:23 INFO - TEST-INFO | 3318: exit 0 14:32:23 INFO - Browser initialized. 14:32:23 INFO - Running cycle 1/1 for dromaeo_css test... 14:32:23 INFO - TEST-INFO | started process 3509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps_OO4k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:32:35 INFO - PID 3509 | RSS: Main: 173940736 14:32:35 INFO - PID 3509 | 14:35:39 INFO - PID 3509 | Cycle 1(1): loaded http://localhost:60270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60270/tests/dromaeo/cssquery-ext.html) 14:35:42 INFO - PID 3509 | RSS: Main: 182390784 14:35:42 INFO - PID 3509 | 14:38:45 INFO - PID 3509 | Cycle 1(1): loaded http://localhost:60270/tests/dromaeo/cssquery-ext.html (next: http://localhost:60270/tests/dromaeo/cssquery-jquery.html) 14:38:45 INFO - PID 3509 | RSS: Main: 177844224 14:38:45 INFO - PID 3509 | 14:41:47 INFO - PID 3509 | Cycle 1(1): loaded http://localhost:60270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60270/tests/dromaeo/cssquery-mootools.html) 14:41:48 INFO - PID 3509 | RSS: Main: 187858944 14:41:48 INFO - PID 3509 | 14:44:50 INFO - PID 3509 | Cycle 1(1): loaded http://localhost:60270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60270/tests/dromaeo/cssquery-prototype.html) 14:44:50 INFO - PID 3509 | RSS: Main: 180088832 14:44:50 INFO - PID 3509 | 14:47:53 INFO - PID 3509 | Cycle 1(1): loaded http://localhost:60270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60270/tests/dromaeo/cssquery-yui.html) 14:47:54 INFO - PID 3509 | RSS: Main: 187195392 14:47:54 INFO - PID 3509 | 14:50:56 INFO - PID 3509 | Cycle 1(1): loaded http://localhost:60270/tests/dromaeo/cssquery-yui.html (next: http://localhost:60270/tests/dromaeo/cssquery-dojo.html) 14:50:56 INFO - PID 3509 | RSS: Main: 189358080 14:50:56 INFO - PID 3509 | 14:50:56 INFO - PID 3509 | __start_tp_report 14:50:56 INFO - PID 3509 | _x_x_mozilla_page_load 14:50:56 INFO - PID 3509 | _x_x_mozilla_page_load_details 14:50:56 INFO - PID 3509 | |i|pagename|runs| 14:50:56 INFO - PID 3509 | |0;dojo.html;2761.8342899426025;2762.7513523782864;2773.0155794692882;2794.8323100613966;2795.9161225163252;5216.165413533835;5235.921461178081;5260.158374660055;5263.078961181792;5264.078786212407;5219.660722053064;5251.264822924793;5295.708736019517;5297.44376840432;5385.461453854622;4424.877450386194;4682.29765535169;4695.084458530588;4701.64737644678;4732.479427263015;4741.383620129378;4771.92842107367;4774.976125119352;4784.928226076611;4802.35168252285;4659.4175728034;4718.103560323562;4724.055188962221;4733;4735.928961065587;4678.947236871677;4708.152532544141;4711.340412342241;4720.693154944917;4762.642801789845;4653.999390131138;4738.3129446230105;4740.051989602059;4742.762861856893;4744;5146.330976973007;5158.277841102249;5165.7158856262895;5191;5228.241904923765;5613.663180209201;5717.828465146053;5723.198752174657;5723.627964182315;5739.913901291484;5715.085586306171;5780.265920223916;5790.04464263396;5802.100674395433;5835.708214589254;5342.065138600729;5358.27663265462;5369.48989845964;5372.8656783579945;5378.865528361822;5828.6211396259105;5831.008728516163;5857.414258574108;5886.970565147232;5900.881982360329;5480.123180291134;5484.643498172606;5576.749046292926;5607.214989901417;5610.635308704921;5734.39788822176;5735.885282294331;5740.311162660424;5744.798932037359;5749.252597162342;5662.009148399014;5691.459311365414;5697.259356283656;5704.857378565486;5707.34365547959;5635.154726791015;5640.915386269209;5701.857453563694;5728.99742545053;5735.8852822944145;4739.099571081483;4756.048790241965;4756.619470442356;4772;4782.736949467812;4049.083423877879;4054.5134583850127;4090.3250963591267;4102.159057393227;4126.133511962522;4857.975710121426;4911.312416261726;4936.136176169156;4936.506349365107;4968.378952630921;5719;5720.628159169724;5773.797917072882;5798;5821.126830975303;4874.2201247800185;4882.707037577757;4884.682495637772;4911.140550403665;4920.975395123001;5033.219850923113;5042.117629414838;5052.671576347526;5054.342935418372;5087.186050232019;5241.31862857826;5276.736163191748;5300.920486192633;5309.46905309466;5341.092014357491;5780.739866705924;5785.739641716217;5786.1899334094105;5787.36339002701;5795.8551036224435;5302.7083510405755;5324.707141107277;5346.866328341823;5355.196720491957;5364.436734143015;5653.773849045992;5664.915026274692;5669.34802497718;5670.744816483186;5683.460071293221;5743.9138412923;5763.9135412968;5776;5780.439281393916;5781.306243250837;5503.972480137573;5565.777368905198;5571.359293681278;5576.442355764391;5582.190582365615;5553.16702494629;5559.805406810742;5560.860978475571;5622.8313150605545;5628.74670639814;5433.619646624698;5458.344998600193;5488.862778430571;5504.6421982571;5508.44915508446;5525.972370138124;5594.9720251398485;5600.60795744294;5632.690202038927;5672.48947594702;5398.973005134949;5411.729413529387;5465.890682186414;5473.67157970523;5482.80810171642 14:50:56 INFO - PID 3509 | |1;ext.html;733.6625152429882;750.8610906982209;1035.6841163445151;1054.5465449856558;1058.9258751887362;29714.405711885778;32291.192720181978;32463.67536324642;32535.51196732048;32595.185120372003;30443;30696.53955190674;30786.38427231454;30813.537796933066;30828.38343233134;6119.357467465908;6202.224721909762;6241.687915604224;6249.843753906143;6844.1444819397575;5836.562257830658;5846.795362162326;5854.5023672987845;5873.236479257691;5885.588008839383;5819.9418005819825;5854.619449735754;5882.382349853268;5902.6458412495385;5905.4094590541035;5825.359210486843;5832.1834943108;5857.297124345063;5865.032269675498;5882.3529411764675;6792.864142717168;6821.863562728768;6866.519343645947;6869.484788640872;6877.140357455318;30834.229144271572;31083.533746993813;31089.22276943072;31117.844410778027;31150.688493115005;2969.732724054845;2981.1354707134906;2995.58061871336;3001.5497675348656;3002;23513;23833.285001449985;23903.163389281464;23977.040918363244;24013.39966500834;2651.708312085669;2698.6896506901567;2736.7126451722484;2762.502749505088;2763.6407267055356;140533;141784;141872.2906385472;142697;143150;38165.618343816204;39873.80063099666;40201.59798402037;40266;40365.394519082234;41833;41880.1623967519;42007;42065;42136.1572768549;12002.63992080239;12036.939815301042;12046.518139274505;12135.089868259916;12146.331951742563;9336.066393360745;9349.205317547949;9435.150836424755;9437.669681561112;9459.90540094604;12828.80756788649;12862.935685321514;12901.354932253349;12933.224006559636;12997.415116319788;5247.632665713363;5256.634514468505;5301.655392399482;5314.0700377433795;5337.119375303031;888.2494292322976;915.5330781301584;915.5925613102106;919.287552147078;949.4208532794989;19962.30131945375;20386.59226815485;21264;21378.14487420517;21536.461588460414;980.2305190425482;999.9200063994863;1010.4190090697731;1030.1449796668746;1034.7464871106476;10709.678709638723;11253.718657033476;11262.38056906878;11283.66149015531;11313.094952403788;168969;169712;169794;170673;170852.14573927052;39395.80302098471;39593.40609890854;39618.80190599086;39677.80161099176;39702.801485992386;1226.4603574427224;1269.1940617707637;1272.204871955028;1273.7898246789362;1281.4938099450665;19379;19506.253527821198;20150.39548813538;20736.48158796042;21096;27712.168634940983;27881;27914.720852792023;27925;27946.301342466602;145778.2711086438;146914;147299.2635036818;148495.25752371168;148521;28708.138755837357;28979.565306520843;29262.561061583667;30238.54642180325;30373.240668983453;36207;36459;36478;36586.26827463489;36783;26034.088806892425;26560.203193904214;26653.7334626659;27808.582871257353;27849.721502785524;26929.865350673907;27062.864685676446;27388.315292117855;28484.715152848206;28652.85673571619;29668.961586344376;29819.850900745358;30236.092917212518;30252.394952100396;30527.54208686827;26269.4746105073;26455.7354426461;26802.195934122006;26810.100489564607;28048.85975570109;20340.59318813645;22241.77758222397;22323.330300091024;22329;22379.552408951404 14:50:56 INFO - PID 3509 | |2;jquery.html;404.4701441112143;410.9424680544722;424.4121891180714;426.63735824549127;428.7856071964018;16124.19379031048;16666.41667541635;16775.916120419395;18637.720434193463;19306.4208073758;18788.90605546974;19080.71378929317;19417;19547.413577592695;19625.803741962576;5359.249705041298;5381.865453363658;5584.91622625661;5622.8313150605545;5632.662040277576;5511.145772405263;5520.337559492847;5544.473275038865;5561.360443548983;5561.972190139064;5407.242985981966;5492.642978206423;5522.006038912994;5547.472990065938;5574.331080270374;5522.30971128609;5526.41972592878;5542.39033706292;5545.611807173499;5554.77780888768;4918.79489525065;5033.949660503385;5035.1188542005;5046.016026874761;5047.268146118829;21526.56946861054;21637.242696505706;21944.670829937564;22386.328410147722;22641.886790566106;1579.0288972282078;1603.1583418705156;1609.8792590555638;1611.9677606447806;1616.5635278474863;14121;14212.857871421256;14299.57101286963;14328.92835535826;14790.630234244123;2013.6677448221026;2024.1498570600384;2125.861818981761;2154.5475450155486;2155.80597746202;82669;83304.58347708284;91879.54060229723;96244;98893.5055324726;11041.33751974884;11146.219764616399;11385.316880987168;11412.657620271239;11430;15729.213539323217;15746.763798542803;15755.369785208693;15792.131432771308;15927.840721592867;7590.278923502258;7891.565963872042;7965.522068675782;8079.353651707849;8167.714130005421;7248.492605517668;7314.232005639331;7558.811029724301;7559.3196612305155;7603.695852165962;7017.333353331425;7084.539504932163;7201;7236.746713864989;7287.161976372785;2102.6425507663735;2104.126787383219;2115.65091759861;2137.700721898935;2286.085565773704;851.1913682002123;851.7444766570004;865.299107722734;873.6112429968603;892.2861710631469;16829.41097061597;16875;17009.747563109224;17111.74332385015;17558.473245802645;866.3718803867146;870.7431307764225;872.2760109109424;876.59676548787;894.9239314658197;9033.77415564616;9342.112499312554;9386.48374339418;9581.952090239503;9611.231101511863;317361;322485;323816;323870;324404;65324.673376633764;70969;71706.64146679234;72691;73862.26137738662;1045.2265323660436;1053.847192157133;1085.5332207151;1087.0705546757567;1090.1006669497697;16881.746773798648;17239.7414038792;17764.28942842272;17862.821371786114;17911.23863988525;36624.45063323999;36923.815380922926;37485.4377184337;37780.81109594544;37865.242695146495;45515.08969820651;45733.54266457293;45997;46054.53945460502;46125.76937115293;8282.50304981703;8326.751777020292;8511.574421278787;8525.147485251426;8632.352573557135;12239.143259971717;12470.314132722788;12620.495180193057;12677.87322126767;12982.285974271506;10940;10966.670999870017;11286.604968826052;11342.319460832376;11419.828702569303;10386.792264154827;10475.52860121281;10626.89373106259;10639.414832183995;10963.342199468058;10777.08394786452;10888;11353.432328383713;11450.37022963745;11495.712607184887;7842.29419352261;7872.488288261245;7932.36541076724;7965.243301886311;8166.101728809945;11199.272047316897;11276.3797991108;11437.199396042197;11469.254498457574;11507.424628768695 14:50:56 INFO - PID 3509 | |3;mootools.html;1243.875612438756;1286.9163504372216;1302.4659889445318;1315.7171208190243;1315.9144655597388;9177.082291770828;9534.427934323929;9557.18763905068;9581.137697607213;9829;9607.951960240207;9688.564014619342;9773.657921972732;9777.31558790885;9801.068898454654;2206.933791986239;2235.9217427390045;2238.8880555972137;2242.316093591454;2247.045005872506;2110.9366718998454;2150.9784902151014;2164.653655415134;2169;2174.3694328644674;2176.249194028058;2180.2587120379067;2220.85564438311;2221.7556068832414;2223.6219842626792;2107.1150116950917;2141.3254824730316;2141.4218161096496;2142.4215461825297;2144.967825482619;2000.4898750818447;2080.2615071649498;2119.5548934723724;2126.723525941633;2140.571885622882;9372.250219982454;9452.10205030521;9459.054094590554;9485.620575176985;9504.192143667728;5226.712530810804;5436.184572314145;5438.428964958662;5441.428649991733;5451.64564303323;3121.750259979196;3239.1416274687226;3299.6700329967052;3304;3363.730901527872;1016.8576399304103;1041.182671602788;1046.8220402531588;1051.3218973761957;1052.747340638249;13688.589342319747;13736.115415762702;13794.93102534491;13918.860811391958;13930.930345348208;4555.589996900295;4593.563611456973;4825.638077144228;4848.10310092627;4849.9030019399415;10141.94929025365;10155.898441015495;10183.745406364753;10223.335483193569;10227.386356818615;5411.675299482044;5453.809116680897;5460.781568737206;5462.098753705594;5466.508014278734;4801.759912004386;5083.517065878736;5105.183170692746;5219.6607220531305;5228.790848366023;3732.2908647356917;3744.4757733916726;3834.482344883405;3870.787106709102;3982.5021872265966;1078.6710053433621;1081.1783044885942;1082.604849230041;1098.7692584557333;1104.0560320925492;666.986660266792;694.0560837261321;695.4193248637343;706.3501578547748;708.716513394636;5375.569954403716;5380;5545.223668686387;5643.717814109278;5684.857878553069;547.4552819944101;561.2171021425171;561.4890449690762;561.5732043646858;565.8613639658311;3161.604799400075;3458.4639380896;3474.965250347464;3521.454174602941;3550.3609350316674;11898.940505297418;12228.755424891453;12252.877471225353;12512.436940337706;12529.373531323397;11907.88092119085;12255.14214005029;12259.141860069887;12291.385430728427;12303.261804291771;7117.82205444868;7296.233895440902;7305.817354566072;7327.670254838545;7331.706731730777;5129.435762066095;5140.3831540215415;5212.218167274939;5354.866128346823;5400.405955344988;10923.25227963522;10989.120870330515;11054.668359949215;11094.223404361617;11101.50043248072;11184.217104802585;11188.944055279671;11272.436378181223;11449.48477318506;11586.015188709054;6795.082663840319;6885.449164066963;6892.414144797748;6896.689648965909;6907.654617269016;8843.823123537364;9040.231580315747;9042.276617870686;9077.31920106008;9079.727608171765;7806.102298235775;7882.763517094496;7892.289693927574;7908.683652653829;7921.920780792118;7706.614669266626;7715.267049630276;7814.57019863913;7982.640781164978;8029.3175080118845;6530.8040758777315;6640.468762499085;6645.169353830771;6652.135222421054;6672.366125218096;4837.274408838562;4961.255811628284;4993;5016.473270306711;5226.97386513065;4990.251462280542;5009.799608015638;5082.186850103965;5122.462141475092;5150.1502252127975 14:50:56 INFO - PID 3509 | |4;prototype.html;363.0488121122659;373.4398402396404;374.3916136278547;379.82907691538804;383.48804346197824;5519.282493275879;5529.695866727334;5616.157576363547;5626.662400255987;5746.48281654651;5448.42791506892;5534.4742249486235;5544.641562817115;5549.250851135105;5565.6660600364;4033.878983630481;4121.629053385194;4146.3158578834455;4156.418101465797;4175.102352994106;4164.97917510412;4169.437125987998;4182.769947652878;4183.016991007111;4184.66522678185;4126.8142933567915;4129.236091323115;4145.626893579577;4150.83396664133;4150.854720084798;4085.2850751118435;4090.8772736817646;4098.52866920305;4133.9173216535655;4150.3359462486005;3575.0883524701035;3578.910527236814;3579.319929213441;3586.246888153491;3606.6213047630145;5259.553622753735;5265.473452654742;5276.7889284428575;5286.259923610698;5338.866528336784;4775.952240477585;4811.59101476375;4886.682365646222;4893;4901.950980490185;5851.444112809277;5855.004649209644;5892.791977644615;5897.941020589782;5905.261842269716;4008.2584721826556;4012.6388625023596;4016.196760647882;4023.114914718757;4034.6080602192196;6098.695065246764;6176.660283684396;6227;6253.78111766086;6326.5255105867245;4087.7751723654887;4091.2022155679356;4093.8976525586504;4097.323941549611;4100.36444351126;4148.958510414917;4165.6461649963885;4173.207090652766;4179.874603761892;4184.644305234028;4632.745199014086;4822.818409489698;4852.51474852519;4866.489018653061;4874.53691899269;5869.941300587025;5872.324682661463;5876.882462350729;5889.998700220973;5909.852253693692;1397.7134687389264;1409.745326659274;1410.3723842889815;1411.9929400352933;1412.4632639596887;887.5207388010531;946.7491114854569;951.9861347664715;959;961.3174646001418;5106.374474123414;5121.359830021247;5130.615203859726;5133.178691409356;5135.563477104413;6105.206323177958;6136.355682653347;6143.170671959318;6158.107074474176;6173.228346456693;4952.653314268039;5125.564327032244;5149.510796474329;5153.6907785532985;5173.534381905646;3223.693749093832;3253.463178575556;3260.4457242268873;3269.918252043718;3283.753718471124;5477.890442191134;5655.575831812548;5663.433656634304;5680.630759000652;5708.40061793514;6085.574009819358;6261.436470717657;6318.115463835067;6325.367463253638;6332.620042797447;5634.929363420937;5647.576431767634;5675.3757086720425;5682.261306030272;5692.544596432358;6124.713810099929;6164.630122192682;6164.76704659061;6169.598976066542;6194.81415557534;5938.495227905676;6008.489278411209;6031.487323577545;6036.154938308729;6057.333693293646;5683.630564013326;5697.4302569742695;5712.343080545625;5714.314282286152;5717.685527295872;4005.859794907281;4108.938365924573;4117.993864479007;4118.794060296913;4124.793760312033;6111.541634377529;6132.325444201224;6143.539234557516;6158.445739883432;6165.84585385369;5930.406959304035;5930.614510056833;5937.614055086406;5941.940580594139;5953.849919819411;5688.77244910199;5879.323877753942;5885.882282354243;5993.940060599338;6001.309849367379;5852.531797456279;5855.151003104611;5890;5893.263342082239;5903.586748927534;5819.243498345188;5988.461038506555;6046.606970546901;6050.122732203894;6053.697315134314;5793.681347525927;5798.507126894261;5801.996622330578;5833.387494313036;5854.677992710442 14:50:56 INFO - PID 3509 | |5;yui.html;685.4310921934795;710.6944014073946;739.641273982119;749.9587522686253;770.9653065612046;12711.555095571657;13013.73972520549;13133.146345487537;13674.042817002814;13696.109752866068;13964.09233399831;14169.29153542324;14219.14685118891;14285.571432857005;14556.563303100924;829.9709510167145;848.4569875279826;852.1350828908662;852.7825404521839;858.0518527027638;898.1602201941173;899.8200359928007;900.7027680865299;901.7835719427324;903.2954295649404;942.5098948546786;942.8491441369382;943.2783920300975;943.5470973932516;962.033156677538;932.6129656192672;937.0208132501552;938.9108034736723;939.0421769794771;957.3633533700081;683.2927919603187;688.2532452289272;688.3770187979886;688.5283580747205;695.9686814093378;14373.928130359385;14684.26578671062;14740.852591474055;14741;14843.10941343512;15602;15682.451114210948;15776.605584860356;15984.440544581;16052.438164664181;11109.722256943642;11200;11286.887131128666;12070.456829442695;12183.93908030463;2870.72728090831;2870.956935645967;2886.826790392583;2888.523393640047;2905.3898681276955;63612;64035;64632.67683661599;65616;66467;11143.2199746017;11391.430428478709;11400.828987565194;11505.13711471643;11512.136589755635;21895.343139705834;21897.890510547346;22120.2257920972;22212.666809997863;22544.549109017727;6089.665068421279;6217.316095229521;6223.097650840603;6241.18864547615;6263.592866463757;2971.06411480383;3023.3046399328277;3023.591815104977;3025.334426426227;3032.348045170299;3517.683408493248;3566.268914872445;3567.1795487038125;3576.3204991051616;3625.857854775737;730.6967608442437;736.4623824607959;744.6649007946446;745.9627018649154;746.5222257755041;545.9645123066988;547.8575570351737;563.1299642053037;582.4175824175824;584.5732615190934;8804.559772011375;9292.303077269233;9728.562214700356;9877.012298770209;10057.295989280827;592.1118322516226;600.6006006006045;613.7176898626682;618.9938100618937;621.6798348850346;3845.1540661054523;3989.3018721723583;4009.5789942055662;4027.7180597357906;4055.1078762672164;58975.410245896994;59733;60203.59185632613;61961.38038619556;62576.06135907965;52095.21857172145;52775.47224527782;53320;53508.73245633747;53527.46472535303;49208.99999999929;49582.50417495851;50226.49773502292;50496.49503504991;50783.23825142626;8673.219410253107;8927.107289271022;8943.463392196489;8954.507502087448;9305.069493050642;25851.612225817003;25963.61054584145;25965.480690386463;26220;26931.865340673172;31458;31584;31655.683443165275;31903.521447177845;32336.67663323337;12100.818487722516;12683.746325073262;12702.745945081231;12754.68113297175;12902.612921612366;15669.294881730122;15697.843021569639;15749.212539373215;15801.051936883823;15869.841301586835;13317.400716967566;13795.17228966225;13903.026788124735;14046.438142474186;14102.435902564193;13378.063535552807;13518.59444216675;13600.387982541008;13704.52034178799;13783.035187536776;13311.667208319483;13596.1842289459;13625.523106691218;13646.727065458834;13788.793168102286;9691.176250018827;10178.745531361776;10454.581816727246;10458.111060559937;10886.51010704536;9965.25260605472;10021.749456263651;10505.842412363667;11171.66485005451;12713.17364371313 14:50:56 INFO - PID 3509 | __end_tp_report 14:50:56 INFO - PID 3509 | __start_cc_report 14:50:56 INFO - PID 3509 | _x_x_mozilla_cycle_collect,355 14:50:56 INFO - PID 3509 | __end_cc_report 14:50:56 INFO - PID 3509 | __startTimestamp1494280256736__endTimestamp 14:50:56 INFO - PID 3509 | 14:50:56 INFO - PID 3509 | ------- Summary: start ------- 14:50:56 INFO - PID 3509 | Number of tests: 6 14:50:56 INFO - PID 3509 | 14:50:56 INFO - PID 3509 | [#0] dojo.html Cycles:165 Average:5226.48 Median:5372.87 stddev:616.97 (11.5%) stddev-sans-first:587.78 14:50:56 INFO - PID 3509 | Values: 2761.8 2762.8 2773.0 2794.8 2795.9 5216.2 5235.9 5260.2 5263.1 5264.1 5219.7 5251.3 5295.7 5297.4 5385.5 4424.9 4682.3 4695.1 4701.6 4732.5 4741.4 4771.9 4775.0 4784.9 4802.4 4659.4 4718.1 4724.1 4733.0 4735.9 4678.9 4708.2 4711.3 4720.7 4762.6 4654.0 4738.3 4740.1 4742.8 4744.0 5146.3 5158.3 5165.7 5191.0 5228.2 5613.7 5717.8 5723.2 5723.6 5739.9 5715.1 5780.3 5790.0 5802.1 5835.7 5342.1 5358.3 5369.5 5372.9 5378.9 5828.6 5831.0 5857.4 5887.0 5900.9 5480.1 5484.6 5576.7 5607.2 5610.6 5734.4 5735.9 5740.3 5744.8 5749.3 5662.0 5691.5 5697.3 5704.9 5707.3 5635.2 5640.9 5701.9 5729.0 5735.9 4739.1 4756.0 4756.6 4772.0 4782.7 4049.1 4054.5 4090.3 4102.2 4126.1 4858.0 4911.3 4936.1 4936.5 4968.4 5719.0 5720.6 5773.8 5798.0 5821.1 4874.2 4882.7 4884.7 4911.1 4921.0 5033.2 5042.1 5052.7 5054.3 5087.2 5241.3 5276.7 5300.9 5309.5 5341.1 5780.7 5785.7 5786.2 5787.4 5795.9 5302.7 5324.7 5346.9 5355.2 5364.4 5653.8 5664.9 5669.3 5670.7 5683.5 5743.9 5763.9 5776.0 5780.4 5781.3 5504.0 5565.8 5571.4 5576.4 5582.2 5553.2 5559.8 5560.9 5622.8 5628.7 5433.6 5458.3 5488.9 5504.6 5508.4 5526.0 5595.0 5600.6 5632.7 5672.5 5399.0 5411.7 5465.9 5473.7 5482.8 14:50:56 INFO - PID 3509 | 14:50:56 INFO - PID 3509 | [#1] ext.html Cycles:180 Average:29396.96 Median:16342.07 stddev:39653.50 (242.6%) stddev-sans-first:39706.32 14:50:56 INFO - PID 3509 | Values: 733.7 750.9 1035.7 1054.5 1058.9 29714.4 32291.2 32463.7 32535.5 32595.2 30443.0 30696.5 30786.4 30813.5 30828.4 6119.4 6202.2 6241.7 6249.8 6844.1 5836.6 5846.8 5854.5 5873.2 5885.6 5819.9 5854.6 5882.4 5902.6 5905.4 5825.4 5832.2 5857.3 5865.0 5882.4 6792.9 6821.9 6866.5 6869.5 6877.1 30834.2 31083.5 31089.2 31117.8 31150.7 2969.7 2981.1 2995.6 3001.5 3002.0 23513.0 23833.3 23903.2 23977.0 24013.4 2651.7 2698.7 2736.7 2762.5 2763.6 140533.0 141784.0 141872.3 142697.0 143150.0 38165.6 39873.8 40201.6 40266.0 40365.4 41833.0 41880.2 42007.0 42065.0 42136.2 12002.6 12036.9 12046.5 12135.1 12146.3 9336.1 9349.2 9435.2 9437.7 9459.9 12828.8 12862.9 12901.4 12933.2 12997.4 5247.6 5256.6 5301.7 5314.1 5337.1 888.2 915.5 915.6 919.3 949.4 19962.3 20386.6 21264.0 21378.1 21536.5 980.2 999.9 1010.4 1030.1 1034.7 10709.7 11253.7 11262.4 11283.7 11313.1 168969.0 169712.0 169794.0 170673.0 170852.1 39395.8 39593.4 39618.8 39677.8 39702.8 1226.5 1269.2 1272.2 1273.8 1281.5 19379.0 19506.3 20150.4 20736.5 21096.0 27712.2 27881.0 27914.7 27925.0 27946.3 145778.3 146914.0 147299.3 148495.3 148521.0 28708.1 28979.6 29262.6 30238.5 30373.2 36207.0 36459.0 36478.0 36586.3 36783.0 26034.1 26560.2 26653.7 27808.6 27849.7 26929.9 27062.9 27388.3 28484.7 28652.9 29669.0 29819.9 30236.1 30252.4 30527.5 26269.5 26455.7 26802.2 26810.1 28048.9 20340.6 22241.8 22323.3 22329.0 22379.6 14:50:56 INFO - PID 3509 | 14:50:56 INFO - PID 3509 | [#2] jquery.html Cycles:180 Average:23430.98 Median:36774.13 stddev:54032.44 (146.9%) stddev-sans-first:54156.36 14:50:56 INFO - PID 3509 | Values: 404.5 410.9 424.4 426.6 428.8 16124.2 16666.4 16775.9 18637.7 19306.4 18788.9 19080.7 19417.0 19547.4 19625.8 5359.2 5381.9 5584.9 5622.8 5632.7 5511.1 5520.3 5544.5 5561.4 5562.0 5407.2 5492.6 5522.0 5547.5 5574.3 5522.3 5526.4 5542.4 5545.6 5554.8 4918.8 5033.9 5035.1 5046.0 5047.3 21526.6 21637.2 21944.7 22386.3 22641.9 1579.0 1603.2 1609.9 1612.0 1616.6 14121.0 14212.9 14299.6 14328.9 14790.6 2013.7 2024.1 2125.9 2154.5 2155.8 82669.0 83304.6 91879.5 96244.0 98893.5 11041.3 11146.2 11385.3 11412.7 11430.0 15729.2 15746.8 15755.4 15792.1 15927.8 7590.3 7891.6 7965.5 8079.4 8167.7 7248.5 7314.2 7558.8 7559.3 7603.7 7017.3 7084.5 7201.0 7236.7 7287.2 2102.6 2104.1 2115.7 2137.7 2286.1 851.2 851.7 865.3 873.6 892.3 16829.4 16875.0 17009.7 17111.7 17558.5 866.4 870.7 872.3 876.6 894.9 9033.8 9342.1 9386.5 9582.0 9611.2 317361.0 322485.0 323816.0 323870.0 324404.0 65324.7 70969.0 71706.6 72691.0 73862.3 1045.2 1053.8 1085.5 1087.1 1090.1 16881.7 17239.7 17764.3 17862.8 17911.2 36624.5 36923.8 37485.4 37780.8 37865.2 45515.1 45733.5 45997.0 46054.5 46125.8 8282.5 8326.8 8511.6 8525.1 8632.4 12239.1 12470.3 12620.5 12677.9 12982.3 10940.0 10966.7 11286.6 11342.3 11419.8 10386.8 10475.5 10626.9 10639.4 10963.3 10777.1 10888.0 11353.4 11450.4 11495.7 7842.3 7872.5 7932.4 7965.2 8166.1 11199.3 11276.4 11437.2 11469.3 11507.4 14:50:56 INFO - PID 3509 | 14:50:56 INFO - PID 3509 | [#3] mootools.html Cycles:180 Average:5907.22 Median:4849.00 stddev:3715.70 (76.6%) stddev-sans-first:3709.60 14:50:56 INFO - PID 3509 | Values: 1243.9 1286.9 1302.5 1315.7 1315.9 9177.1 9534.4 9557.2 9581.1 9829.0 9608.0 9688.6 9773.7 9777.3 9801.1 2206.9 2235.9 2238.9 2242.3 2247.0 2110.9 2151.0 2164.7 2169.0 2174.4 2176.2 2180.3 2220.9 2221.8 2223.6 2107.1 2141.3 2141.4 2142.4 2145.0 2000.5 2080.3 2119.6 2126.7 2140.6 9372.3 9452.1 9459.1 9485.6 9504.2 5226.7 5436.2 5438.4 5441.4 5451.6 3121.8 3239.1 3299.7 3304.0 3363.7 1016.9 1041.2 1046.8 1051.3 1052.7 13688.6 13736.1 13794.9 13918.9 13930.9 4555.6 4593.6 4825.6 4848.1 4849.9 10141.9 10155.9 10183.7 10223.3 10227.4 5411.7 5453.8 5460.8 5462.1 5466.5 4801.8 5083.5 5105.2 5219.7 5228.8 3732.3 3744.5 3834.5 3870.8 3982.5 1078.7 1081.2 1082.6 1098.8 1104.1 667.0 694.1 695.4 706.4 708.7 5375.6 5380.0 5545.2 5643.7 5684.9 547.5 561.2 561.5 561.6 565.9 3161.6 3458.5 3475.0 3521.5 3550.4 11898.9 12228.8 12252.9 12512.4 12529.4 11907.9 12255.1 12259.1 12291.4 12303.3 7117.8 7296.2 7305.8 7327.7 7331.7 5129.4 5140.4 5212.2 5354.9 5400.4 10923.3 10989.1 11054.7 11094.2 11101.5 11184.2 11188.9 11272.4 11449.5 11586.0 6795.1 6885.4 6892.4 6896.7 6907.7 8843.8 9040.2 9042.3 9077.3 9079.7 7806.1 7882.8 7892.3 7908.7 7921.9 7706.6 7715.3 7814.6 7982.6 8029.3 6530.8 6640.5 6645.2 6652.1 6672.4 4837.3 4961.3 4993.0 5016.5 5227.0 4990.3 5009.8 5082.2 5122.5 5150.2 14:50:56 INFO - PID 3509 | 14:50:56 INFO - PID 3509 | [#4] prototype.html Cycles:180 Average:4834.95 Median:5546.95 stddev:1467.01 (26.4%) stddev-sans-first:1432.22 14:50:56 INFO - PID 3509 | Values: 363.0 373.4 374.4 379.8 383.5 5519.3 5529.7 5616.2 5626.7 5746.5 5448.4 5534.5 5544.6 5549.3 5565.7 4033.9 4121.6 4146.3 4156.4 4175.1 4165.0 4169.4 4182.8 4183.0 4184.7 4126.8 4129.2 4145.6 4150.8 4150.9 4085.3 4090.9 4098.5 4133.9 4150.3 3575.1 3578.9 3579.3 3586.2 3606.6 5259.6 5265.5 5276.8 5286.3 5338.9 4776.0 4811.6 4886.7 4893.0 4902.0 5851.4 5855.0 5892.8 5897.9 5905.3 4008.3 4012.6 4016.2 4023.1 4034.6 6098.7 6176.7 6227.0 6253.8 6326.5 4087.8 4091.2 4093.9 4097.3 4100.4 4149.0 4165.6 4173.2 4179.9 4184.6 4632.7 4822.8 4852.5 4866.5 4874.5 5869.9 5872.3 5876.9 5890.0 5909.9 1397.7 1409.7 1410.4 1412.0 1412.5 887.5 946.7 952.0 959.0 961.3 5106.4 5121.4 5130.6 5133.2 5135.6 6105.2 6136.4 6143.2 6158.1 6173.2 4952.7 5125.6 5149.5 5153.7 5173.5 3223.7 3253.5 3260.4 3269.9 3283.8 5477.9 5655.6 5663.4 5680.6 5708.4 6085.6 6261.4 6318.1 6325.4 6332.6 5634.9 5647.6 5675.4 5682.3 5692.5 6124.7 6164.6 6164.8 6169.6 6194.8 5938.5 6008.5 6031.5 6036.2 6057.3 5683.6 5697.4 5712.3 5714.3 5717.7 4005.9 4108.9 4118.0 4118.8 4124.8 6111.5 6132.3 6143.5 6158.4 6165.8 5930.4 5930.6 5937.6 5941.9 5953.8 5688.8 5879.3 5885.9 5993.9 6001.3 5852.5 5855.2 5890.0 5893.3 5903.6 5819.2 5988.5 6046.6 6050.1 6053.7 5793.7 5798.5 5802.0 5833.4 5854.7 14:50:56 INFO - PID 3509 | 14:50:56 INFO - PID 3509 | [#5] yui.html Cycles:180 Average:14596.78 Median:3566.72 stddev:16958.89 (475.5%) stddev-sans-first:16974.29 14:50:56 INFO - PID 3509 | Values: 685.4 710.7 739.6 750.0 771.0 12711.6 13013.7 13133.1 13674.0 13696.1 13964.1 14169.3 14219.1 14285.6 14556.6 830.0 848.5 852.1 852.8 858.1 898.2 899.8 900.7 901.8 903.3 942.5 942.8 943.3 943.5 962.0 932.6 937.0 938.9 939.0 957.4 683.3 688.3 688.4 688.5 696.0 14373.9 14684.3 14740.9 14741.0 14843.1 15602.0 15682.5 15776.6 15984.4 16052.4 11109.7 11200.0 11286.9 12070.5 12183.9 2870.7 2871.0 2886.8 2888.5 2905.4 63612.0 64035.0 64632.7 65616.0 66467.0 11143.2 11391.4 11400.8 11505.1 11512.1 21895.3 21897.9 22120.2 22212.7 22544.5 6089.7 6217.3 6223.1 6241.2 6263.6 2971.1 3023.3 3023.6 3025.3 3032.3 3517.7 3566.3 3567.2 3576.3 3625.9 730.7 736.5 744.7 746.0 746.5 546.0 547.9 563.1 582.4 584.6 8804.6 9292.3 9728.6 9877.0 10057.3 592.1 600.6 613.7 619.0 621.7 3845.2 3989.3 4009.6 4027.7 4055.1 58975.4 59733.0 60203.6 61961.4 62576.1 52095.2 52775.5 53320.0 53508.7 53527.5 49209.0 49582.5 50226.5 50496.5 50783.2 8673.2 8927.1 8943.5 8954.5 9305.1 25851.6 25963.6 25965.5 26220.0 26931.9 31458.0 31584.0 31655.7 31903.5 32336.7 12100.8 12683.7 12702.7 12754.7 12902.6 15669.3 15697.8 15749.2 15801.1 15869.8 13317.4 13795.2 13903.0 14046.4 14102.4 13378.1 13518.6 13600.4 13704.5 13783.0 13311.7 13596.2 13625.5 13646.7 13788.8 9691.2 10178.7 10454.6 10458.1 10886.5 9965.3 10021.7 10505.8 11171.7 12713.2 14:50:56 INFO - PID 3509 | -------- Summary: end -------- 14:50:56 INFO - PID 3509 | 14:50:57 INFO - TEST-INFO | 3509: exit 0 14:50:57 INFO - TEST-OK | dromaeo_css | took 1121871ms 14:50:57 INFO - TEST-START | kraken 14:50:57 INFO - operating with platform_type : linux_ 14:50:57 INFO - Initialising browser for kraken test... 14:50:57 INFO - TEST-INFO | started process 3945 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3RnOeV/profile http://localhost:60270/getInfo.html) 14:51:01 INFO - PID 3945 | __metrics Screen width/height:1600/1200 14:51:01 INFO - PID 3945 | colorDepth:24 14:51:01 INFO - PID 3945 | Browser inner width/height: 1024/695 14:51:01 INFO - PID 3945 | __metrics 14:51:04 INFO - TEST-INFO | 3945: exit 0 14:51:04 INFO - Browser initialized. 14:51:04 INFO - Running cycle 1/1 for kraken test... 14:51:04 INFO - TEST-INFO | started process 4139 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3RnOeV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:51:16 INFO - PID 4139 | RSS: Main: 173871104 14:51:16 INFO - PID 4139 | 14:51:18 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60270/tests/kraken/driver.html?testName=audio-beat-detection) 14:51:19 INFO - PID 4139 | RSS: Main: 181497856 14:51:19 INFO - PID 4139 | 14:51:22 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60270/tests/kraken/driver.html?testName=audio-dft) 14:51:23 INFO - PID 4139 | RSS: Main: 181174272 14:51:23 INFO - PID 4139 | 14:51:26 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60270/tests/kraken/driver.html?testName=audio-fft) 14:51:26 INFO - PID 4139 | RSS: Main: 178225152 14:51:26 INFO - PID 4139 | 14:51:28 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60270/tests/kraken/driver.html?testName=audio-oscillator) 14:51:29 INFO - PID 4139 | RSS: Main: 177446912 14:51:29 INFO - PID 4139 | 14:51:31 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:51:32 INFO - PID 4139 | RSS: Main: 179159040 14:51:32 INFO - PID 4139 | 14:51:35 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60270/tests/kraken/driver.html?testName=imaging-darkroom) 14:51:35 INFO - PID 4139 | RSS: Main: 184459264 14:51:35 INFO - PID 4139 | 14:51:39 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60270/tests/kraken/driver.html?testName=imaging-desaturate) 14:51:40 INFO - PID 4139 | RSS: Main: 182521856 14:51:40 INFO - PID 4139 | 14:51:42 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60270/tests/kraken/driver.html?testName=json-parse-financial) 14:51:43 INFO - PID 4139 | RSS: Main: 183762944 14:51:43 INFO - PID 4139 | 14:51:45 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:51:45 INFO - PID 4139 | RSS: Main: 184868864 14:51:45 INFO - PID 4139 | 14:51:47 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60270/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:51:48 INFO - PID 4139 | RSS: Main: 185769984 14:51:48 INFO - PID 4139 | 14:51:50 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:51:51 INFO - PID 4139 | RSS: Main: 185417728 14:51:51 INFO - PID 4139 | 14:51:53 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:51:54 INFO - PID 4139 | RSS: Main: 185487360 14:51:54 INFO - PID 4139 | 14:51:57 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:51:58 INFO - PID 4139 | RSS: Main: 185999360 14:51:58 INFO - PID 4139 | 14:52:00 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60270/tests/kraken/driver.html?testName=ai-astar) 14:52:00 INFO - PID 4139 | RSS: Main: 188018688 14:52:00 INFO - PID 4139 | 14:52:00 INFO - PID 4139 | __start_tp_report 14:52:00 INFO - PID 4139 | _x_x_mozilla_page_load 14:52:00 INFO - PID 4139 | _x_x_mozilla_page_load_details 14:52:00 INFO - PID 4139 | |i|pagename|runs| 14:52:00 INFO - PID 4139 | |0;ai-astar;104;112;114;112;112;113;112;114;114;113 14:52:00 INFO - PID 4139 | |1;audio-beat-detection;155;123;123;174;129;123;122;124;143;122 14:52:00 INFO - PID 4139 | |2;audio-dft;163;166;165;164;171;170;164;165;163;163 14:52:00 INFO - PID 4139 | |3;audio-fft;75;75;75;105;74;75;75;74;94;75 14:52:00 INFO - PID 4139 | |4;audio-oscillator;82;82;106;84;85;86;100;83;84;109 14:52:00 INFO - PID 4139 | |5;imaging-gaussian-blur;115;114;115;114;113;113;125;119;114;114 14:52:00 INFO - PID 4139 | |6;imaging-darkroom;150;150;151;151;149;150;150;153;150;150 14:52:00 INFO - PID 4139 | |7;imaging-desaturate;96;94;96;95;95;94;95;95;95;94 14:52:00 INFO - PID 4139 | |8;json-parse-financial;54;54;56;54;61;57;58;55;54;55 14:52:00 INFO - PID 4139 | |9;json-stringify-tinderbox;55;56;55;56;56;56;55;55;56;55 14:52:00 INFO - PID 4139 | |10;stanford-crypto-aes;85;83;82;82;80;80;81;82;82;83 14:52:00 INFO - PID 4139 | |11;stanford-crypto-ccm;132;134;140;130;132;133;137;132;227;132 14:52:00 INFO - PID 4139 | |12;stanford-crypto-pbkdf2;188;185;180;183;180;179;178;190;190;189 14:52:00 INFO - PID 4139 | |13;stanford-crypto-sha256-iterative;73;73;70;74;73;73;75;72;70;72 14:52:00 INFO - PID 4139 | __end_tp_report 14:52:00 INFO - PID 4139 | __start_cc_report 14:52:00 INFO - PID 4139 | _x_x_mozilla_cycle_collect,835 14:52:00 INFO - PID 4139 | __end_cc_report 14:52:00 INFO - PID 4139 | __startTimestamp1494280320342__endTimestamp 14:52:00 INFO - PID 4139 | 14:52:00 INFO - PID 4139 | ------- Summary: start ------- 14:52:00 INFO - PID 4139 | Number of tests: 14 14:52:00 INFO - PID 4139 | 14:52:00 INFO - PID 4139 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.94 (2.6%) stddev-sans-first:0.93 14:52:00 INFO - PID 4139 | Values: 104.0 112.0 114.0 112.0 112.0 113.0 112.0 114.0 114.0 113.0 14:52:00 INFO - PID 4139 | 14:52:00 INFO - PID 4139 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:126.50 stddev:17.94 (14.2%) stddev-sans-first:17.31 14:52:00 INFO - PID 4139 | Values: 155.0 123.0 123.0 174.0 129.0 123.0 122.0 124.0 143.0 122.0 14:52:00 INFO - PID 4139 | 14:52:00 INFO - PID 4139 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.00 stddev:2.88 (1.7%) stddev-sans-first:2.92 14:52:00 INFO - PID 4139 | Values: 163.0 166.0 165.0 164.0 171.0 170.0 164.0 165.0 163.0 163.0 14:52:00 INFO - PID 4139 | 14:52:00 INFO - PID 4139 | [#3] audio-fft Cycles:10 Average:79.70 Median:75.00 stddev:10.76 (14.3%) stddev-sans-first:11.28 14:52:00 INFO - PID 4139 | Values: 75.0 75.0 75.0 105.0 74.0 75.0 75.0 74.0 94.0 75.0 14:52:00 INFO - PID 4139 | 14:52:00 INFO - PID 4139 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:83.50 stddev:10.58 (12.7%) stddev-sans-first:10.81 14:52:00 INFO - PID 4139 | Values: 82.0 82.0 106.0 84.0 85.0 86.0 100.0 83.0 84.0 109.0 14:52:00 INFO - PID 4139 | 14:52:00 INFO - PID 4139 | [#5] imaging-gaussian-blur Cycles:10 Average:115.60 Median:114.50 stddev:3.72 (3.2%) stddev-sans-first:3.94 14:52:00 INFO - PID 4139 | Values: 115.0 114.0 115.0 114.0 113.0 113.0 125.0 119.0 114.0 114.0 14:52:00 INFO - PID 4139 | 14:52:00 INFO - PID 4139 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 14:52:00 INFO - PID 4139 | Values: 150.0 150.0 151.0 151.0 149.0 150.0 150.0 153.0 150.0 150.0 14:52:00 INFO - PID 4139 | 14:52:00 INFO - PID 4139 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 14:52:00 INFO - PID 4139 | Values: 96.0 94.0 96.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 14:52:00 INFO - PID 4139 | 14:52:00 INFO - PID 4139 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.50 stddev:2.30 (4.1%) stddev-sans-first:2.35 14:52:00 INFO - PID 4139 | Values: 54.0 54.0 56.0 54.0 61.0 57.0 58.0 55.0 54.0 55.0 14:52:00 INFO - PID 4139 | 14:52:00 INFO - PID 4139 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:56.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 14:52:00 INFO - PID 4139 | Values: 55.0 56.0 55.0 56.0 56.0 56.0 55.0 55.0 56.0 55.0 14:52:00 INFO - PID 4139 | 14:52:00 INFO - PID 4139 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:1.49 (1.8%) stddev-sans-first:1.12 14:52:00 INFO - PID 4139 | Values: 85.0 83.0 82.0 82.0 80.0 80.0 81.0 82.0 82.0 83.0 14:52:00 INFO - PID 4139 | 14:52:00 INFO - PID 4139 | [#11] stanford-crypto-ccm Cycles:10 Average:142.90 Median:133.50 stddev:29.69 (22.2%) stddev-sans-first:31.23 14:52:00 INFO - PID 4139 | Values: 132.0 134.0 140.0 130.0 132.0 133.0 137.0 132.0 227.0 132.0 14:52:00 INFO - PID 4139 | 14:52:00 INFO - PID 4139 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.20 Median:186.50 stddev:4.80 (2.6%) stddev-sans-first:4.89 14:52:00 INFO - PID 4139 | Values: 188.0 185.0 180.0 183.0 180.0 179.0 178.0 190.0 190.0 189.0 14:52:00 INFO - PID 4139 | 14:52:00 INFO - PID 4139 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:73.00 stddev:1.58 (2.2%) stddev-sans-first:1.67 14:52:00 INFO - PID 4139 | Values: 73.0 73.0 70.0 74.0 73.0 73.0 75.0 72.0 70.0 72.0 14:52:00 INFO - PID 4139 | -------- Summary: end -------- 14:52:00 INFO - PID 4139 | 14:52:01 INFO - TEST-INFO | 4139: exit 0 14:52:01 INFO - TEST-OK | kraken | took 64083ms 14:52:01 INFO - SUITE-END | took 1185s 14:52:02 INFO - Completed test suite (00:19:46) 14:52:02 INFO - javascript benchmark 14:52:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6608.427335068521, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2761.8342899426025, 2762.7513523782864, 2773.0155794692882, 2794.8323100613966, 2795.9161225163252, 5216.165413533835, 5235.921461178081, 5260.158374660055, 5263.078961181792, 5264.078786212407, 5219.660722053064, 5251.264822924793, 5295.708736019517, 5297.44376840432, 5385.461453854622, 4424.877450386194, 4682.29765535169, 4695.084458530588, 4701.64737644678, 4732.479427263015, 4741.383620129378, 4771.92842107367, 4774.976125119352, 4784.928226076611, 4802.35168252285, 4659.4175728034, 4718.103560323562, 4724.055188962221, 4733.0, 4735.928961065587, 4678.947236871677, 4708.152532544141, 4711.340412342241, 4720.693154944917, 4762.642801789845, 4653.999390131138, 4738.3129446230105, 4740.051989602059, 4742.762861856893, 4744.0, 5146.330976973007, 5158.277841102249, 5165.7158856262895, 5191.0, 5228.241904923765, 5613.663180209201, 5717.828465146053, 5723.198752174657, 5723.627964182315, 5739.913901291484, 5715.085586306171, 5780.265920223916, 5790.04464263396, 5802.100674395433, 5835.708214589254, 5342.065138600729, 5358.27663265462, 5369.48989845964, 5372.8656783579945, 5378.865528361822, 5828.6211396259105, 5831.008728516163, 5857.414258574108, 5886.970565147232, 5900.881982360329, 5480.123180291134, 5484.643498172606, 5576.749046292926, 5607.214989901417, 5610.635308704921, 5734.39788822176, 5735.885282294331, 5740.311162660424, 5744.798932037359, 5749.252597162342, 5662.009148399014, 5691.459311365414, 5697.259356283656, 5704.857378565486, 5707.34365547959, 5635.154726791015, 5640.915386269209, 5701.857453563694, 5728.99742545053, 5735.8852822944145, 4739.099571081483, 4756.048790241965, 4756.619470442356, 4772.0, 4782.736949467812, 4049.083423877879, 4054.5134583850127, 4090.3250963591267, 4102.159057393227, 4126.133511962522, 4857.975710121426, 4911.312416261726, 4936.136176169156, 4936.506349365107, 4968.378952630921, 5719.0, 5720.628159169724, 5773.797917072882, 5798.0, 5821.126830975303, 4874.2201247800185, 4882.707037577757, 4884.682495637772, 4911.140550403665, 4920.975395123001, 5033.219850923113, 5042.117629414838, 5052.671576347526, 5054.342935418372, 5087.186050232019, 5241.31862857826, 5276.736163191748, 5300.920486192633, 5309.46905309466, 5341.092014357491, 5780.739866705924, 5785.739641716217, 5786.1899334094105, 5787.36339002701, 5795.8551036224435, 5302.7083510405755, 5324.707141107277, 5346.866328341823, 5355.196720491957, 5364.436734143015, 5653.773849045992, 5664.915026274692, 5669.34802497718, 5670.744816483186, 5683.460071293221, 5743.9138412923, 5763.9135412968, 5776.0, 5780.439281393916, 5781.306243250837, 5503.972480137573, 5565.777368905198, 5571.359293681278, 5576.442355764391, 5582.190582365615, 5553.16702494629, 5559.805406810742, 5560.860978475571, 5622.8313150605545, 5628.74670639814, 5433.619646624698, 5458.344998600193, 5488.862778430571, 5504.6421982571, 5508.44915508446, 5525.972370138124, 5594.9720251398485, 5600.60795744294, 5632.690202038927, 5672.48947594702, 5398.973005134949, 5411.729413529387, 5465.890682186414, 5473.67157970523, 5482.80810171642], "value": 5181.660476122996, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.6625152429882, 750.8610906982209, 1035.6841163445151, 1054.5465449856558, 1058.9258751887362, 29714.405711885778, 32291.192720181978, 32463.67536324642, 32535.51196732048, 32595.185120372003, 30443.0, 30696.53955190674, 30786.38427231454, 30813.537796933066, 30828.38343233134, 6119.357467465908, 6202.224721909762, 6241.687915604224, 6249.843753906143, 6844.1444819397575, 5836.562257830658, 5846.795362162326, 5854.5023672987845, 5873.236479257691, 5885.588008839383, 5819.9418005819825, 5854.619449735754, 5882.382349853268, 5902.6458412495385, 5905.4094590541035, 5825.359210486843, 5832.1834943108, 5857.297124345063, 5865.032269675498, 5882.3529411764675, 6792.864142717168, 6821.863562728768, 6866.519343645947, 6869.484788640872, 6877.140357455318, 30834.229144271572, 31083.533746993813, 31089.22276943072, 31117.844410778027, 31150.688493115005, 2969.732724054845, 2981.1354707134906, 2995.58061871336, 3001.5497675348656, 3002.0, 23513.0, 23833.285001449985, 23903.163389281464, 23977.040918363244, 24013.39966500834, 2651.708312085669, 2698.6896506901567, 2736.7126451722484, 2762.502749505088, 2763.6407267055356, 140533.0, 141784.0, 141872.2906385472, 142697.0, 143150.0, 38165.618343816204, 39873.80063099666, 40201.59798402037, 40266.0, 40365.394519082234, 41833.0, 41880.1623967519, 42007.0, 42065.0, 42136.1572768549, 12002.63992080239, 12036.939815301042, 12046.518139274505, 12135.089868259916, 12146.331951742563, 9336.066393360745, 9349.205317547949, 9435.150836424755, 9437.669681561112, 9459.90540094604, 12828.80756788649, 12862.935685321514, 12901.354932253349, 12933.224006559636, 12997.415116319788, 5247.632665713363, 5256.634514468505, 5301.655392399482, 5314.0700377433795, 5337.119375303031, 888.2494292322976, 915.5330781301584, 915.5925613102106, 919.287552147078, 949.4208532794989, 19962.30131945375, 20386.59226815485, 21264.0, 21378.14487420517, 21536.461588460414, 980.2305190425482, 999.9200063994863, 1010.4190090697731, 1030.1449796668746, 1034.7464871106476, 10709.678709638723, 11253.718657033476, 11262.38056906878, 11283.66149015531, 11313.094952403788, 168969.0, 169712.0, 169794.0, 170673.0, 170852.14573927052, 39395.80302098471, 39593.40609890854, 39618.80190599086, 39677.80161099176, 39702.801485992386, 1226.4603574427224, 1269.1940617707637, 1272.204871955028, 1273.7898246789362, 1281.4938099450665, 19379.0, 19506.253527821198, 20150.39548813538, 20736.48158796042, 21096.0, 27712.168634940983, 27881.0, 27914.720852792023, 27925.0, 27946.301342466602, 145778.2711086438, 146914.0, 147299.2635036818, 148495.25752371168, 148521.0, 28708.138755837357, 28979.565306520843, 29262.561061583667, 30238.54642180325, 30373.240668983453, 36207.0, 36459.0, 36478.0, 36586.26827463489, 36783.0, 26034.088806892425, 26560.203193904214, 26653.7334626659, 27808.582871257353, 27849.721502785524, 26929.865350673907, 27062.864685676446, 27388.315292117855, 28484.715152848206, 28652.85673571619, 29668.961586344376, 29819.850900745358, 30236.092917212518, 30252.394952100396, 30527.54208686827, 26269.4746105073, 26455.7354426461, 26802.195934122006, 26810.100489564607, 28048.85975570109, 20340.59318813645, 22241.77758222397, 22323.330300091024, 22329.0, 22379.552408951404], "value": 14021.597233837025, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.4701441112143, 410.9424680544722, 424.4121891180714, 426.63735824549127, 428.7856071964018, 16124.19379031048, 16666.41667541635, 16775.916120419395, 18637.720434193463, 19306.4208073758, 18788.90605546974, 19080.71378929317, 19417.0, 19547.413577592695, 19625.803741962576, 5359.249705041298, 5381.865453363658, 5584.91622625661, 5622.8313150605545, 5632.662040277576, 5511.145772405263, 5520.337559492847, 5544.473275038865, 5561.360443548983, 5561.972190139064, 5407.242985981966, 5492.642978206423, 5522.006038912994, 5547.472990065938, 5574.331080270374, 5522.30971128609, 5526.41972592878, 5542.39033706292, 5545.611807173499, 5554.77780888768, 4918.79489525065, 5033.949660503385, 5035.1188542005, 5046.016026874761, 5047.268146118829, 21526.56946861054, 21637.242696505706, 21944.670829937564, 22386.328410147722, 22641.886790566106, 1579.0288972282078, 1603.1583418705156, 1609.8792590555638, 1611.9677606447806, 1616.5635278474863, 14121.0, 14212.857871421256, 14299.57101286963, 14328.92835535826, 14790.630234244123, 2013.6677448221026, 2024.1498570600384, 2125.861818981761, 2154.5475450155486, 2155.80597746202, 82669.0, 83304.58347708284, 91879.54060229723, 96244.0, 98893.5055324726, 11041.33751974884, 11146.219764616399, 11385.316880987168, 11412.657620271239, 11430.0, 15729.213539323217, 15746.763798542803, 15755.369785208693, 15792.131432771308, 15927.840721592867, 7590.278923502258, 7891.565963872042, 7965.522068675782, 8079.353651707849, 8167.714130005421, 7248.492605517668, 7314.232005639331, 7558.811029724301, 7559.3196612305155, 7603.695852165962, 7017.333353331425, 7084.539504932163, 7201.0, 7236.746713864989, 7287.161976372785, 2102.6425507663735, 2104.126787383219, 2115.65091759861, 2137.700721898935, 2286.085565773704, 851.1913682002123, 851.7444766570004, 865.299107722734, 873.6112429968603, 892.2861710631469, 16829.41097061597, 16875.0, 17009.747563109224, 17111.74332385015, 17558.473245802645, 866.3718803867146, 870.7431307764225, 872.2760109109424, 876.59676548787, 894.9239314658197, 9033.77415564616, 9342.112499312554, 9386.48374339418, 9581.952090239503, 9611.231101511863, 317361.0, 322485.0, 323816.0, 323870.0, 324404.0, 65324.673376633764, 70969.0, 71706.64146679234, 72691.0, 73862.26137738662, 1045.2265323660436, 1053.847192157133, 1085.5332207151, 1087.0705546757567, 1090.1006669497697, 16881.746773798648, 17239.7414038792, 17764.28942842272, 17862.821371786114, 17911.23863988525, 36624.45063323999, 36923.815380922926, 37485.4377184337, 37780.81109594544, 37865.242695146495, 45515.08969820651, 45733.54266457293, 45997.0, 46054.53945460502, 46125.76937115293, 8282.50304981703, 8326.751777020292, 8511.574421278787, 8525.147485251426, 8632.352573557135, 12239.143259971717, 12470.314132722788, 12620.495180193057, 12677.87322126767, 12982.285974271506, 10940.0, 10966.670999870017, 11286.604968826052, 11342.319460832376, 11419.828702569303, 10386.792264154827, 10475.52860121281, 10626.89373106259, 10639.414832183995, 10963.342199468058, 10777.08394786452, 10888.0, 11353.432328383713, 11450.37022963745, 11495.712607184887, 7842.29419352261, 7872.488288261245, 7932.36541076724, 7965.243301886311, 8166.101728809945, 11199.272047316897, 11276.3797991108, 11437.199396042197, 11469.254498457574, 11507.424628768695], "value": 8843.21492039437, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1243.875612438756, 1286.9163504372216, 1302.4659889445318, 1315.7171208190243, 1315.9144655597388, 9177.082291770828, 9534.427934323929, 9557.18763905068, 9581.137697607213, 9829.0, 9607.951960240207, 9688.564014619342, 9773.657921972732, 9777.31558790885, 9801.068898454654, 2206.933791986239, 2235.9217427390045, 2238.8880555972137, 2242.316093591454, 2247.045005872506, 2110.9366718998454, 2150.9784902151014, 2164.653655415134, 2169.0, 2174.3694328644674, 2176.249194028058, 2180.2587120379067, 2220.85564438311, 2221.7556068832414, 2223.6219842626792, 2107.1150116950917, 2141.3254824730316, 2141.4218161096496, 2142.4215461825297, 2144.967825482619, 2000.4898750818447, 2080.2615071649498, 2119.5548934723724, 2126.723525941633, 2140.571885622882, 9372.250219982454, 9452.10205030521, 9459.054094590554, 9485.620575176985, 9504.192143667728, 5226.712530810804, 5436.184572314145, 5438.428964958662, 5441.428649991733, 5451.64564303323, 3121.750259979196, 3239.1416274687226, 3299.6700329967052, 3304.0, 3363.730901527872, 1016.8576399304103, 1041.182671602788, 1046.8220402531588, 1051.3218973761957, 1052.747340638249, 13688.589342319747, 13736.115415762702, 13794.93102534491, 13918.860811391958, 13930.930345348208, 4555.589996900295, 4593.563611456973, 4825.638077144228, 4848.10310092627, 4849.9030019399415, 10141.94929025365, 10155.898441015495, 10183.745406364753, 10223.335483193569, 10227.386356818615, 5411.675299482044, 5453.809116680897, 5460.781568737206, 5462.098753705594, 5466.508014278734, 4801.759912004386, 5083.517065878736, 5105.183170692746, 5219.6607220531305, 5228.790848366023, 3732.2908647356917, 3744.4757733916726, 3834.482344883405, 3870.787106709102, 3982.5021872265966, 1078.6710053433621, 1081.1783044885942, 1082.604849230041, 1098.7692584557333, 1104.0560320925492, 666.986660266792, 694.0560837261321, 695.4193248637343, 706.3501578547748, 708.716513394636, 5375.569954403716, 5380.0, 5545.223668686387, 5643.717814109278, 5684.857878553069, 547.4552819944101, 561.2171021425171, 561.4890449690762, 561.5732043646858, 565.8613639658311, 3161.604799400075, 3458.4639380896, 3474.965250347464, 3521.454174602941, 3550.3609350316674, 11898.940505297418, 12228.755424891453, 12252.877471225353, 12512.436940337706, 12529.373531323397, 11907.88092119085, 12255.14214005029, 12259.141860069887, 12291.385430728427, 12303.261804291771, 7117.82205444868, 7296.233895440902, 7305.817354566072, 7327.670254838545, 7331.706731730777, 5129.435762066095, 5140.3831540215415, 5212.218167274939, 5354.866128346823, 5400.405955344988, 10923.25227963522, 10989.120870330515, 11054.668359949215, 11094.223404361617, 11101.50043248072, 11184.217104802585, 11188.944055279671, 11272.436378181223, 11449.48477318506, 11586.015188709054, 6795.082663840319, 6885.449164066963, 6892.414144797748, 6896.689648965909, 6907.654617269016, 8843.823123537364, 9040.231580315747, 9042.276617870686, 9077.31920106008, 9079.727608171765, 7806.102298235775, 7882.763517094496, 7892.289693927574, 7908.683652653829, 7921.920780792118, 7706.614669266626, 7715.267049630276, 7814.57019863913, 7982.640781164978, 8029.3175080118845, 6530.8040758777315, 6640.468762499085, 6645.169353830771, 6652.135222421054, 6672.366125218096, 4837.274408838562, 4961.255811628284, 4993.0, 5016.473270306711, 5226.97386513065, 4990.251462280542, 5009.799608015638, 5082.186850103965, 5122.462141475092, 5150.1502252127975], "value": 4471.417739871487, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.0488121122659, 373.4398402396404, 374.3916136278547, 379.82907691538804, 383.48804346197824, 5519.282493275879, 5529.695866727334, 5616.157576363547, 5626.662400255987, 5746.48281654651, 5448.42791506892, 5534.4742249486235, 5544.641562817115, 5549.250851135105, 5565.6660600364, 4033.878983630481, 4121.629053385194, 4146.3158578834455, 4156.418101465797, 4175.102352994106, 4164.97917510412, 4169.437125987998, 4182.769947652878, 4183.016991007111, 4184.66522678185, 4126.8142933567915, 4129.236091323115, 4145.626893579577, 4150.83396664133, 4150.854720084798, 4085.2850751118435, 4090.8772736817646, 4098.52866920305, 4133.9173216535655, 4150.3359462486005, 3575.0883524701035, 3578.910527236814, 3579.319929213441, 3586.246888153491, 3606.6213047630145, 5259.553622753735, 5265.473452654742, 5276.7889284428575, 5286.259923610698, 5338.866528336784, 4775.952240477585, 4811.59101476375, 4886.682365646222, 4893.0, 4901.950980490185, 5851.444112809277, 5855.004649209644, 5892.791977644615, 5897.941020589782, 5905.261842269716, 4008.2584721826556, 4012.6388625023596, 4016.196760647882, 4023.114914718757, 4034.6080602192196, 6098.695065246764, 6176.660283684396, 6227.0, 6253.78111766086, 6326.5255105867245, 4087.7751723654887, 4091.2022155679356, 4093.8976525586504, 4097.323941549611, 4100.36444351126, 4148.958510414917, 4165.6461649963885, 4173.207090652766, 4179.874603761892, 4184.644305234028, 4632.745199014086, 4822.818409489698, 4852.51474852519, 4866.489018653061, 4874.53691899269, 5869.941300587025, 5872.324682661463, 5876.882462350729, 5889.998700220973, 5909.852253693692, 1397.7134687389264, 1409.745326659274, 1410.3723842889815, 1411.9929400352933, 1412.4632639596887, 887.5207388010531, 946.7491114854569, 951.9861347664715, 959.0, 961.3174646001418, 5106.374474123414, 5121.359830021247, 5130.615203859726, 5133.178691409356, 5135.563477104413, 6105.206323177958, 6136.355682653347, 6143.170671959318, 6158.107074474176, 6173.228346456693, 4952.653314268039, 5125.564327032244, 5149.510796474329, 5153.6907785532985, 5173.534381905646, 3223.693749093832, 3253.463178575556, 3260.4457242268873, 3269.918252043718, 3283.753718471124, 5477.890442191134, 5655.575831812548, 5663.433656634304, 5680.630759000652, 5708.40061793514, 6085.574009819358, 6261.436470717657, 6318.115463835067, 6325.367463253638, 6332.620042797447, 5634.929363420937, 5647.576431767634, 5675.3757086720425, 5682.261306030272, 5692.544596432358, 6124.713810099929, 6164.630122192682, 6164.76704659061, 6169.598976066542, 6194.81415557534, 5938.495227905676, 6008.489278411209, 6031.487323577545, 6036.154938308729, 6057.333693293646, 5683.630564013326, 5697.4302569742695, 5712.343080545625, 5714.314282286152, 5717.685527295872, 4005.859794907281, 4108.938365924573, 4117.993864479007, 4118.794060296913, 4124.793760312033, 6111.541634377529, 6132.325444201224, 6143.539234557516, 6158.445739883432, 6165.84585385369, 5930.406959304035, 5930.614510056833, 5937.614055086406, 5941.940580594139, 5953.849919819411, 5688.77244910199, 5879.323877753942, 5885.882282354243, 5993.940060599338, 6001.309849367379, 5852.531797456279, 5855.151003104611, 5890.0, 5893.263342082239, 5903.586748927534, 5819.243498345188, 5988.461038506555, 6046.606970546901, 6050.122732203894, 6053.697315134314, 5793.681347525927, 5798.507126894261, 5801.996622330578, 5833.387494313036, 5854.677992710442], "value": 4374.515833545196, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.4310921934795, 710.6944014073946, 739.641273982119, 749.9587522686253, 770.9653065612046, 12711.555095571657, 13013.73972520549, 13133.146345487537, 13674.042817002814, 13696.109752866068, 13964.09233399831, 14169.29153542324, 14219.14685118891, 14285.571432857005, 14556.563303100924, 829.9709510167145, 848.4569875279826, 852.1350828908662, 852.7825404521839, 858.0518527027638, 898.1602201941173, 899.8200359928007, 900.7027680865299, 901.7835719427324, 903.2954295649404, 942.5098948546786, 942.8491441369382, 943.2783920300975, 943.5470973932516, 962.033156677538, 932.6129656192672, 937.0208132501552, 938.9108034736723, 939.0421769794771, 957.3633533700081, 683.2927919603187, 688.2532452289272, 688.3770187979886, 688.5283580747205, 695.9686814093378, 14373.928130359385, 14684.26578671062, 14740.852591474055, 14741.0, 14843.10941343512, 15602.0, 15682.451114210948, 15776.605584860356, 15984.440544581, 16052.438164664181, 11109.722256943642, 11200.0, 11286.887131128666, 12070.456829442695, 12183.93908030463, 2870.72728090831, 2870.956935645967, 2886.826790392583, 2888.523393640047, 2905.3898681276955, 63612.0, 64035.0, 64632.67683661599, 65616.0, 66467.0, 11143.2199746017, 11391.430428478709, 11400.828987565194, 11505.13711471643, 11512.136589755635, 21895.343139705834, 21897.890510547346, 22120.2257920972, 22212.666809997863, 22544.549109017727, 6089.665068421279, 6217.316095229521, 6223.097650840603, 6241.18864547615, 6263.592866463757, 2971.06411480383, 3023.3046399328277, 3023.591815104977, 3025.334426426227, 3032.348045170299, 3517.683408493248, 3566.268914872445, 3567.1795487038125, 3576.3204991051616, 3625.857854775737, 730.6967608442437, 736.4623824607959, 744.6649007946446, 745.9627018649154, 746.5222257755041, 545.9645123066988, 547.8575570351737, 563.1299642053037, 582.4175824175824, 584.5732615190934, 8804.559772011375, 9292.303077269233, 9728.562214700356, 9877.012298770209, 10057.295989280827, 592.1118322516226, 600.6006006006045, 613.7176898626682, 618.9938100618937, 621.6798348850346, 3845.1540661054523, 3989.3018721723583, 4009.5789942055662, 4027.7180597357906, 4055.1078762672164, 58975.410245896994, 59733.0, 60203.59185632613, 61961.38038619556, 62576.06135907965, 52095.21857172145, 52775.47224527782, 53320.0, 53508.73245633747, 53527.46472535303, 49208.99999999929, 49582.50417495851, 50226.49773502292, 50496.49503504991, 50783.23825142626, 8673.219410253107, 8927.107289271022, 8943.463392196489, 8954.507502087448, 9305.069493050642, 25851.612225817003, 25963.61054584145, 25965.480690386463, 26220.0, 26931.865340673172, 31458.0, 31584.0, 31655.683443165275, 31903.521447177845, 32336.67663323337, 12100.818487722516, 12683.746325073262, 12702.745945081231, 12754.68113297175, 12902.612921612366, 15669.294881730122, 15697.843021569639, 15749.212539373215, 15801.051936883823, 15869.841301586835, 13317.400716967566, 13795.17228966225, 13903.026788124735, 14046.438142474186, 14102.435902564193, 13378.063535552807, 13518.59444216675, 13600.387982541008, 13704.52034178799, 13783.035187536776, 13311.667208319483, 13596.1842289459, 13625.523106691218, 13646.727065458834, 13788.793168102286, 9691.176250018827, 10178.745531361776, 10454.581816727246, 10458.111060559937, 10886.51010704536, 9965.25260605472, 10021.749456263651, 10505.842412363667, 11171.66485005451, 12713.17364371313], "value": 6626.822454296111, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 114.0, 112.0, 112.0, 113.0, 112.0, 114.0, 114.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 123.0, 123.0, 174.0, 129.0, 123.0, 122.0, 124.0, 143.0, 122.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 165.0, 164.0, 171.0, 170.0, 164.0, 165.0, 163.0, 163.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 105.0, 74.0, 75.0, 75.0, 74.0, 94.0, 75.0], "value": 79.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 106.0, 84.0, 85.0, 86.0, 100.0, 83.0, 84.0, 109.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 114.0, 113.0, 113.0, 125.0, 119.0, 114.0, 114.0], "value": 115.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 151.0, 149.0, 150.0, 150.0, 153.0, 150.0, 150.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 56.0, 54.0, 61.0, 57.0, 58.0, 55.0, 54.0, 55.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 56.0, 56.0, 56.0, 55.0, 55.0, 56.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 82.0, 82.0, 80.0, 80.0, 81.0, 82.0, 82.0, 83.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 134.0, 140.0, 130.0, 132.0, 133.0, 137.0, 132.0, 227.0, 132.0], "value": 142.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 185.0, 180.0, 183.0, 180.0, 179.0, 178.0, 190.0, 190.0, 189.0], "value": 184.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 70.0, 74.0, 73.0, 73.0, 75.0, 72.0, 70.0, 72.0], "value": 72.5, "unit": "score"}]}]} 14:52:02 INFO - Return code: 0 14:52:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:52:02 INFO - # TBPL SUCCESS # 14:52:02 INFO - Running post-action listener: _resource_record_post_action 14:52:02 INFO - [mozharness: 2017-05-08 21:52:02.165644Z] Finished run-tests step (success) 14:52:02 INFO - Running post-run listener: _resource_record_post_run 14:52:02 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 7962624; Write bytes: 372297728; Read time: 1832; Write time: 256188 14:52:02 INFO - TinderboxPrint: CPU usage
13.3% 14:52:02 INFO - TinderboxPrint: I/O read bytes / time
7,962,624 / 1,832 14:52:02 INFO - TinderboxPrint: I/O write bytes / time
372,297,728 / 256,188 14:52:02 INFO - TinderboxPrint: CPU idle
8,318.3 (86.7%) 14:52:02 INFO - TinderboxPrint: CPU user
1,217.9 (12.7%) 14:52:02 INFO - TinderboxPrint: Swap in / out
0 / 0 14:52:02 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110964736; Read time: 0; Write time: 108188 14:52:02 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 5931008; Write bytes: 261332992; Read time: 1744; Write time: 148000 14:52:02 INFO - Running post-run listener: _upload_blobber_files 14:52:02 INFO - Blob upload gear active. 14:52:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:52:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:52:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:52:03 INFO - (blobuploader) - INFO - Open directory for files ... 14:52:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:52:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:52:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:03 INFO - (blobuploader) - INFO - Done attempting. 14:52:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:52:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:52:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:06 INFO - (blobuploader) - INFO - Done attempting. 14:52:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:52:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:52:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:07 INFO - (blobuploader) - INFO - Done attempting. 14:52:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:52:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:52:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:08 INFO - (blobuploader) - INFO - Done attempting. 14:52:08 INFO - (blobuploader) - INFO - Iteration through files over. 14:52:08 INFO - Return code: 0 14:52:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:52:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:52:08 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbf5fcfcd32d36621b7627682c6d1f5da5f84a2c224678ea8f1c14ec6bb1a3ffc1a4430511c4f8f0fd7521f2e051cf885bbce900ab1d868b898c8f4284d345c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0032d109543b93c16ecccf9a771252b24bec96e77191b6e64f5643c7f623cdc69ee2a66373bd31e9b64c79514a16aa5ce0debe0231ce9210d1ea0c2e0da35810", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcdd222cb9253c81874a8d5ab70ea96e64060348dd6708f0b6b7dd7fc4e2287582a1764ba0fc816203a9190f0354a3e90ad438a006e186620038c3300eb9f471", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cd5815fe1b73e018576fbbbd285fa9d5bada04d7ad36b8c9e2351307ba91f1e8d0e7311e2d5ddca06ea9bf0cd649813f5b67205a8eed49d93439e1ac33b7df6"} 14:52:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:52:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:52:08 INFO - Contents: 14:52:08 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbf5fcfcd32d36621b7627682c6d1f5da5f84a2c224678ea8f1c14ec6bb1a3ffc1a4430511c4f8f0fd7521f2e051cf885bbce900ab1d868b898c8f4284d345c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0032d109543b93c16ecccf9a771252b24bec96e77191b6e64f5643c7f623cdc69ee2a66373bd31e9b64c79514a16aa5ce0debe0231ce9210d1ea0c2e0da35810", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcdd222cb9253c81874a8d5ab70ea96e64060348dd6708f0b6b7dd7fc4e2287582a1764ba0fc816203a9190f0354a3e90ad438a006e186620038c3300eb9f471", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cd5815fe1b73e018576fbbbd285fa9d5bada04d7ad36b8c9e2351307ba91f1e8d0e7311e2d5ddca06ea9bf0cd649813f5b67205a8eed49d93439e1ac33b7df6"} 14:52:08 INFO - Running post-run listener: copy_logs_to_upload_dir 14:52:08 INFO - Copying logs to upload dir... 14:52:08 INFO - mkdir: /builds/slave/test/build/upload/logs 14:52:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.273840 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-05-08 14:52:08.531448) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 14:52:08.536011) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321 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/sha512/bbf5fcfcd32d36621b7627682c6d1f5da5f84a2c224678ea8f1c14ec6bb1a3ffc1a4430511c4f8f0fd7521f2e051cf885bbce900ab1d868b898c8f4284d345c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0032d109543b93c16ecccf9a771252b24bec96e77191b6e64f5643c7f623cdc69ee2a66373bd31e9b64c79514a16aa5ce0debe0231ce9210d1ea0c2e0da35810", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcdd222cb9253c81874a8d5ab70ea96e64060348dd6708f0b6b7dd7fc4e2287582a1764ba0fc816203a9190f0354a3e90ad438a006e186620038c3300eb9f471", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cd5815fe1b73e018576fbbbd285fa9d5bada04d7ad36b8c9e2351307ba91f1e8d0e7311e2d5ddca06ea9bf0cd649813f5b67205a8eed49d93439e1ac33b7df6"} build_url:https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011143 build_url: 'https://queue.taskcluster.net/v1/task/FwB1HLWIQt6yclQF3vLb-A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbf5fcfcd32d36621b7627682c6d1f5da5f84a2c224678ea8f1c14ec6bb1a3ffc1a4430511c4f8f0fd7521f2e051cf885bbce900ab1d868b898c8f4284d345c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0032d109543b93c16ecccf9a771252b24bec96e77191b6e64f5643c7f623cdc69ee2a66373bd31e9b64c79514a16aa5ce0debe0231ce9210d1ea0c2e0da35810", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcdd222cb9253c81874a8d5ab70ea96e64060348dd6708f0b6b7dd7fc4e2287582a1764ba0fc816203a9190f0354a3e90ad438a006e186620038c3300eb9f471", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cd5815fe1b73e018576fbbbd285fa9d5bada04d7ad36b8c9e2351307ba91f1e8d0e7311e2d5ddca06ea9bf0cd649813f5b67205a8eed49d93439e1ac33b7df6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 14:52:08.564015) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 14:52:08.564329) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1494279066.685147-596305321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004394 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 14:52:08.643407) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 14:52:08.646736) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 14:52:08.647048) ========= ========= Total master_lag: 0.18 =========