builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-070 starttime: 1489700582.18 results: success (0) revision: 39607304b774591fa6e32c4b06158d869483c312 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-16 14:43:02.178492) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-16 14:43:02.179039) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-16 14:43:02.179379) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-16 14:43:02.194410) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 14:43:02.194783) ========= 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=2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-16 14:43:02-- 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% 45.8M=0s 2017-03-16 14:43:02 (45.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099000 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 14:43:02.311118) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 14:43:02.311513) ========= 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=2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015575 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 14:43:02.361791) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-16 14:43:02.362240) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 39607304b774591fa6e32c4b06158d869483c312 --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 39607304b774591fa6e32c4b06158d869483c312 --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=2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-16 14:43:03,117 truncating revision to first 12 chars 2017-03-16 14:43:03,117 Setting DEBUG logging. 2017-03-16 14:43:03,117 attempt 1/10 2017-03-16 14:43:03,117 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/39607304b774?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-16 14:43:04,254 unpacking tar archive at: mozilla-central-39607304b774/testing/mozharness/ program finished with exit code 0 elapsedTime=1.434174 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-16 14:43:03.813290) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-16 14:43:03.813772) ========= script_repo_revision: 39607304b774591fa6e32c4b06158d869483c312 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-16 14:43:03.814232) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-16 14:43:03.814565) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-16 14:43:03.824219) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-16 14:43:03.824749) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:43:04 INFO - MultiFileLogger online at 20170316 14:43:04 in /builds/slave/test 14:43:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:43:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:43:04 INFO - {'append_to_log': False, 14:43:04 INFO - 'base_work_dir': '/builds/slave/test', 14:43:04 INFO - 'blob_upload_branch': 'Firefox', 14:43:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:43:04 INFO - 'branch': 'Firefox', 14:43:04 INFO - 'buildbot_json_path': 'buildprops.json', 14:43:04 INFO - 'config_files': ('talos/linux_config.py',), 14:43:04 INFO - 'default_actions': ('clobber', 14:43:04 INFO - 'read-buildbot-config', 14:43:04 INFO - 'download-and-extract', 14:43:04 INFO - 'populate-webroot', 14:43:04 INFO - 'create-virtualenv', 14:43:04 INFO - 'install', 14:43:04 INFO - 'run-tests'), 14:43:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:43:04 INFO - 'download_minidump_stackwalk': True, 14:43:04 INFO - 'download_symbols': 'ondemand', 14:43:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:43:04 INFO - 'tooltool.py': '/tools/tooltool.py', 14:43:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:43:04 INFO - '/tools/misc-python/virtualenv.py')}, 14:43:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:43:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:43:04 INFO - 'gecko_profile': False, 14:43:04 INFO - 'gecko_profile_interval': 0, 14:43:04 INFO - 'installer_path': 'installer.exe', 14:43:04 INFO - 'log_level': 'info', 14:43:04 INFO - 'log_name': 'talos', 14:43:04 INFO - 'log_to_console': True, 14:43:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:43:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:43:04 INFO - 'opt_config_files': (), 14:43:04 INFO - 'pip_index': False, 14:43:04 INFO - 'suite': 'dromaeojs', 14:43:04 INFO - 'system_bits': '32', 14:43:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:43:04 INFO - 'title': 'talos-linux64-ix-070', 14:43:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:43:04 INFO - 'use_talos_json': True, 14:43:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:43:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:43:04 INFO - 'work_dir': 'build'} 14:43:04 INFO - [mozharness: 2017-03-16 21:43:04.680137Z] Running clobber step. 14:43:04 INFO - Running pre-action listener: _resource_record_pre_action 14:43:04 INFO - Running main action method: clobber 14:43:04 INFO - rmtree: /builds/slave/test/build 14:43:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:43:05 INFO - Running post-action listener: _resource_record_post_action 14:43:05 INFO - [mozharness: 2017-03-16 21:43:05.609536Z] Finished clobber step (success) 14:43:05 INFO - [mozharness: 2017-03-16 21:43:05.609638Z] Running read-buildbot-config step. 14:43:05 INFO - Running pre-action listener: _resource_record_pre_action 14:43:05 INFO - Running main action method: read_buildbot_config 14:43:05 INFO - Using buildbot properties: 14:43:05 INFO - { 14:43:05 INFO - "project": "", 14:43:05 INFO - "product": "firefox", 14:43:05 INFO - "who": "kwierso@gmail.com", 14:43:05 INFO - "installer_path": "public/build/target.tar.bz2", 14:43:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 14:43:05 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 14:43:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 14:43:05 INFO - "stage_platform": "linux64-pgo", 14:43:05 INFO - "basedir": "/builds/slave/test", 14:43:05 INFO - "buildnumber": 80, 14:43:05 INFO - "platform": "ubuntu64_hw", 14:43:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:43:05 INFO - "slavebuilddir": "test", 14:43:05 INFO - "taskId": "No0BCQvlR-qacMOY2WtLxw", 14:43:05 INFO - "branch": "mozilla-central", 14:43:05 INFO - "script_repo_revision": "production", 14:43:05 INFO - "revision": "39607304b774591fa6e32c4b06158d869483c312", 14:43:05 INFO - "slavename": "talos-linux64-ix-070", 14:43:05 INFO - "repo_path": "mozilla-central" 14:43:05 INFO - } 14:43:05 INFO - Finding installer, test and symbols from parent task. 14:43:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/No0BCQvlR-qacMOY2WtLxw'}, attempt #1 14:43:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/No0BCQvlR-qacMOY2WtLxw'}, attempt #1 14:43:06 INFO - Task dependencies: fwOngqxxRniV0qauGCx8Ew 14:43:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew'}, attempt #1 14:43:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.tar.bz2 14:43:07 INFO - Set test_url: https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/test_packages.json 14:43:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.crashreporter-symbols.zip 14:43:07 INFO - Running post-action listener: _resource_record_post_action 14:43:07 INFO - [mozharness: 2017-03-16 21:43:07.005780Z] Finished read-buildbot-config step (success) 14:43:07 INFO - [mozharness: 2017-03-16 21:43:07.006040Z] Running download-and-extract step. 14:43:07 INFO - Running pre-action listener: _resource_record_pre_action 14:43:07 INFO - Running main action method: download_and_extract 14:43:07 INFO - mkdir: /builds/slave/test/build/tests 14:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:07 INFO - trying https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.test_packages.json 14:43:07 INFO - Downloading https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:43:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:43:07 INFO - Downloaded 986 bytes. 14:43:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:43:07 INFO - Using the following test package requirements: 14:43:07 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:43:07 INFO - u'common': [u'target.common.tests.zip'], 14:43:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:43:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:43:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:43:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:43:07 INFO - u'mozbase': [u'target.common.tests.zip'], 14:43:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:43:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:43:07 INFO - u'web-platform': [u'target.common.tests.zip', 14:43:07 INFO - u'target.web-platform.tests.zip'], 14:43:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:43:07 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:43:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.common.tests.zip 14:43:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:43:07 INFO - Fetch https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.common.tests.zip into memory 14:43:08 INFO - Expected file size: 60312535 14:43:08 INFO - Obtained file size: 60312535 14:43:18 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:43:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.common.tests.zip 14:43:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:43:18 INFO - Fetch https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.common.tests.zip into memory 14:43:20 INFO - Expected file size: 60312535 14:43:20 INFO - Obtained file size: 60312535 14:43:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.talos.tests.zip 14:43:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:43:31 INFO - Fetch https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.talos.tests.zip into memory 14:43:31 INFO - Expected file size: 14404452 14:43:31 INFO - Obtained file size: 14404452 14:43:32 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:43:32 INFO - trying https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.tar.bz2 14:43:32 INFO - Downloading https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:43:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:43:33 INFO - Downloaded 67117771 bytes. 14:43:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.tar.bz2 14:43:33 INFO - mkdir: /builds/slave/test/properties 14:43:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:43:33 INFO - Writing to file /builds/slave/test/properties/build_url 14:43:33 INFO - Contents: 14:43:33 INFO - build_url:https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.tar.bz2 14:43:33 INFO - Running post-action listener: _resource_record_post_action 14:43:33 INFO - Running post-action listener: set_extra_try_arguments 14:43:33 INFO - [mozharness: 2017-03-16 21:43:33.456773Z] Finished download-and-extract step (success) 14:43:33 INFO - [mozharness: 2017-03-16 21:43:33.456871Z] Running populate-webroot step. 14:43:33 INFO - Running pre-action listener: _resource_record_pre_action 14:43:33 INFO - Running main action method: populate_webroot 14:43:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:43:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:43:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:43:33 INFO - '--tppagecycles', 14:43:33 INFO - '7'], 14:43:33 INFO - 'tests': ['tsvgm']}}, 14:43:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:43:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:43:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:43:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:43:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:43:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:43:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:43:33 INFO - 'talos_options': ['--disable-e10s'], 14:43:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:43:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:43:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:43:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:43:33 INFO - 'talos_options': ['--disable-e10s'], 14:43:33 INFO - 'tests': ['damp', 'tps']}, 14:43:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:43:33 INFO - 'tests': ['damp', 'tps']}, 14:43:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:43:33 INFO - 'tests': ['dromaeo_dom']}, 14:43:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:43:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:43:33 INFO - 'tests': ['basic_compositor_video']}, 14:43:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:43:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:43:33 INFO - 'tests': ['a11yr', 14:43:33 INFO - 'ts_paint', 14:43:33 INFO - 'tpaint', 14:43:33 INFO - 'sessionrestore', 14:43:33 INFO - 'sessionrestore_no_auto_restore', 14:43:33 INFO - 'tabpaint']}, 14:43:33 INFO - 'other-e10s': {'tests': ['a11yr', 14:43:33 INFO - 'ts_paint', 14:43:33 INFO - 'tpaint', 14:43:33 INFO - 'sessionrestore', 14:43:33 INFO - 'sessionrestore_no_auto_restore', 14:43:33 INFO - 'tabpaint']}, 14:43:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:43:33 INFO - 'ts_paint', 14:43:33 INFO - 'tpaint', 14:43:33 INFO - 'sessionrestore', 14:43:33 INFO - 'sessionrestore_no_auto_restore', 14:43:33 INFO - 'tabpaint']}, 14:43:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:43:33 INFO - 'ts_paint', 14:43:33 INFO - 'tpaint', 14:43:33 INFO - 'sessionrestore', 14:43:33 INFO - 'sessionrestore_no_auto_restore', 14:43:33 INFO - 'tabpaint']}, 14:43:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:43:33 INFO - 'tests': ['a11yr', 14:43:33 INFO - 'ts_paint', 14:43:33 INFO - 'tpaint', 14:43:33 INFO - 'sessionrestore', 14:43:33 INFO - 'sessionrestore_no_auto_restore', 14:43:33 INFO - 'tabpaint']}, 14:43:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:43:33 INFO - 'tests': ['a11yr', 14:43:33 INFO - 'ts_paint', 14:43:33 INFO - 'tpaint', 14:43:33 INFO - 'sessionrestore', 14:43:33 INFO - 'sessionrestore_no_auto_restore', 14:43:33 INFO - 'tabpaint']}, 14:43:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:43:33 INFO - 'tests': ['tsvgx', 14:43:33 INFO - 'tsvgr_opacity', 14:43:33 INFO - 'tart', 14:43:33 INFO - 'tscrollx', 14:43:33 INFO - 'cart', 14:43:33 INFO - 'tsvg_static']}, 14:43:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:43:33 INFO - 'tsvgr_opacity', 14:43:33 INFO - 'tart', 14:43:33 INFO - 'tscrollx', 14:43:33 INFO - 'cart', 14:43:33 INFO - 'tsvg_static']}, 14:43:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:43:33 INFO - 'talos_options': ['--disable-e10s'], 14:43:33 INFO - 'tests': ['tp5o']}, 14:43:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:43:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:43:33 INFO - 'talos_options': ['--disable-e10s', 14:43:33 INFO - '--xperf_path', 14:43:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:43:33 INFO - 'tests': ['tp5n']}, 14:43:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:43:33 INFO - 'talos_options': ['--xperf_path', 14:43:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:43:33 INFO - 'tests': ['tp5n']}}, 14:43:33 INFO - 'talos.zip': {'path': '', 14:43:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:43:33 INFO - Running post-action listener: _resource_record_post_action 14:43:33 INFO - [mozharness: 2017-03-16 21:43:33.470267Z] Finished populate-webroot step (success) 14:43:33 INFO - [mozharness: 2017-03-16 21:43:33.470359Z] Running create-virtualenv step. 14:43:33 INFO - Running pre-action listener: _resource_record_pre_action 14:43:33 INFO - Running main action method: create_virtualenv 14:43:33 INFO - Creating virtualenv /builds/slave/test/build/venv 14:43:33 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:43:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:43:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:43:33 INFO - Using real prefix '/usr' 14:43:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:43:34 INFO - Installing distribute.............................................................................................................................................................................................done. 14:43:36 INFO - Installing pip.................done. 14:43:36 INFO - Return code: 0 14:43:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:43:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:43:36 INFO - Reading from file tmpfile_stdout 14:43:36 INFO - Output received: 14:43:36 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:43:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:43:36 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:43:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:36 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:43:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:36 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 0x15d21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1870310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186d400>, '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 0x186e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186e840>, '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': '2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882', '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:43:36 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:43:36 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:43:36 INFO - Using env: {'DISPLAY': ':0', 14:43:36 INFO - 'HOME': '/home/cltbld', 14:43:36 INFO - 'LANG': 'en_US.UTF-8', 14:43:36 INFO - 'LANGUAGE': 'en_US:en', 14:43:36 INFO - 'LOGNAME': 'cltbld', 14:43:36 INFO - 'MAIL': '/var/mail/cltbld', 14:43:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:36 INFO - 'MOZ_NO_REMOTE': '1', 14:43:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:36 INFO - 'NO_EM_RESTART': '1', 14:43:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:36 INFO - 'PWD': '/builds/slave/test', 14:43:36 INFO - 'SHELL': '/bin/bash', 14:43:36 INFO - 'SHLVL': '1', 14:43:36 INFO - 'TERM': 'linux', 14:43:36 INFO - 'TMOUT': '86400', 14:43:36 INFO - 'USER': 'cltbld', 14:43:36 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882', 14:43:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:36 INFO - '_': '/tools/buildbot/bin/python'} 14:43:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:36 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:43:36 INFO - Cleaning up... 14:43:36 INFO - Return code: 0 14:43:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:43:36 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:43:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:36 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:43:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:36 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 0x15d21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1870310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186d400>, '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 0x186e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186e840>, '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': '2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882', '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:43:36 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:43:36 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:43:36 INFO - Using env: {'DISPLAY': ':0', 14:43:36 INFO - 'HOME': '/home/cltbld', 14:43:36 INFO - 'LANG': 'en_US.UTF-8', 14:43:36 INFO - 'LANGUAGE': 'en_US:en', 14:43:36 INFO - 'LOGNAME': 'cltbld', 14:43:36 INFO - 'MAIL': '/var/mail/cltbld', 14:43:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:36 INFO - 'MOZ_NO_REMOTE': '1', 14:43:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:36 INFO - 'NO_EM_RESTART': '1', 14:43:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:36 INFO - 'PWD': '/builds/slave/test', 14:43:36 INFO - 'SHELL': '/bin/bash', 14:43:36 INFO - 'SHLVL': '1', 14:43:36 INFO - 'TERM': 'linux', 14:43:36 INFO - 'TMOUT': '86400', 14:43:36 INFO - 'USER': 'cltbld', 14:43:36 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882', 14:43:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:36 INFO - '_': '/tools/buildbot/bin/python'} 14:43:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:36 INFO - Downloading/unpacking psutil>=3.1.1 14:43:36 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:43:36 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:43:36 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:43:36 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:43:36 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:43:36 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:43:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:43:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:43:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:43:38 INFO - Installing collected packages: psutil 14:43:38 INFO - Running setup.py install for psutil 14:43:38 INFO - building 'psutil._psutil_linux' extension 14:43:38 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:43:39 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:43:39 INFO - building 'psutil._psutil_posix' extension 14:43:39 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:43:39 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:43:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:43:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:43:39 INFO - Successfully installed psutil 14:43:39 INFO - Cleaning up... 14:43:39 INFO - Return code: 0 14:43:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:43:39 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:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:39 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:43:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:39 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 0x15d21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1870310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186d400>, '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 0x186e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186e840>, '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': '2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882', '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:43:39 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:43:39 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:43:39 INFO - Using env: {'DISPLAY': ':0', 14:43:39 INFO - 'HOME': '/home/cltbld', 14:43:39 INFO - 'LANG': 'en_US.UTF-8', 14:43:39 INFO - 'LANGUAGE': 'en_US:en', 14:43:39 INFO - 'LOGNAME': 'cltbld', 14:43:39 INFO - 'MAIL': '/var/mail/cltbld', 14:43:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:39 INFO - 'MOZ_NO_REMOTE': '1', 14:43:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:39 INFO - 'NO_EM_RESTART': '1', 14:43:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:39 INFO - 'PWD': '/builds/slave/test', 14:43:39 INFO - 'SHELL': '/bin/bash', 14:43:39 INFO - 'SHLVL': '1', 14:43:39 INFO - 'TERM': 'linux', 14:43:39 INFO - 'TMOUT': '86400', 14:43:39 INFO - 'USER': 'cltbld', 14:43:39 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882', 14:43:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:39 INFO - '_': '/tools/buildbot/bin/python'} 14:43:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:43:39 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:43:39 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:43:39 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:43:39 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:43:39 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:43:39 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:43:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:43:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:43:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:43:41 INFO - Installing collected packages: mozsystemmonitor 14:43:41 INFO - Running setup.py install for mozsystemmonitor 14:43:41 INFO - Successfully installed mozsystemmonitor 14:43:41 INFO - Cleaning up... 14:43:41 INFO - Return code: 0 14:43:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:43:41 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:43:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:41 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:43:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:42 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 0x15d21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1870310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186d400>, '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 0x186e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186e840>, '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': '2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882', '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:43:42 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:43:42 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:43:42 INFO - Using env: {'DISPLAY': ':0', 14:43:42 INFO - 'HOME': '/home/cltbld', 14:43:42 INFO - 'LANG': 'en_US.UTF-8', 14:43:42 INFO - 'LANGUAGE': 'en_US:en', 14:43:42 INFO - 'LOGNAME': 'cltbld', 14:43:42 INFO - 'MAIL': '/var/mail/cltbld', 14:43:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:42 INFO - 'MOZ_NO_REMOTE': '1', 14:43:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:42 INFO - 'NO_EM_RESTART': '1', 14:43:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:42 INFO - 'PWD': '/builds/slave/test', 14:43:42 INFO - 'SHELL': '/bin/bash', 14:43:42 INFO - 'SHLVL': '1', 14:43:42 INFO - 'TERM': 'linux', 14:43:42 INFO - 'TMOUT': '86400', 14:43:42 INFO - 'USER': 'cltbld', 14:43:42 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882', 14:43:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:42 INFO - '_': '/tools/buildbot/bin/python'} 14:43:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:42 INFO - Downloading/unpacking jsonschema==2.5.1 14:43:42 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:43:42 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:43:42 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:43:42 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:43:42 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:43:42 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:43:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:43:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:43:44 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:43:44 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:43:44 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:43:44 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:43:44 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:43:44 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:43:44 INFO - Downloading functools32-3.2.3-2.tar.gz 14:43:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:43:44 INFO - warning: no files found matching '*.txt' 14:43:44 INFO - no previously-included directories found matching 'build' 14:43:44 INFO - no previously-included directories found matching 'dist' 14:43:44 INFO - no previously-included directories found matching '.git*' 14:43:44 INFO - Installing collected packages: jsonschema, functools32 14:43:44 INFO - Running setup.py install for functools32 14:43:44 INFO - warning: no files found matching '*.txt' 14:43:44 INFO - no previously-included directories found matching 'build' 14:43:44 INFO - no previously-included directories found matching 'dist' 14:43:44 INFO - no previously-included directories found matching '.git*' 14:43:44 INFO - Successfully installed jsonschema functools32 14:43:44 INFO - Cleaning up... 14:43:44 INFO - Return code: 0 14:43:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:43:44 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:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:44 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:43:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:44 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 0x15d21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1870310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186d400>, '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 0x186e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186e840>, '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': '2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882', '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:43:44 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:43:44 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:43:44 INFO - Using env: {'DISPLAY': ':0', 14:43:44 INFO - 'HOME': '/home/cltbld', 14:43:44 INFO - 'LANG': 'en_US.UTF-8', 14:43:44 INFO - 'LANGUAGE': 'en_US:en', 14:43:44 INFO - 'LOGNAME': 'cltbld', 14:43:44 INFO - 'MAIL': '/var/mail/cltbld', 14:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:44 INFO - 'MOZ_NO_REMOTE': '1', 14:43:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:44 INFO - 'NO_EM_RESTART': '1', 14:43:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:44 INFO - 'PWD': '/builds/slave/test', 14:43:44 INFO - 'SHELL': '/bin/bash', 14:43:44 INFO - 'SHLVL': '1', 14:43:44 INFO - 'TERM': 'linux', 14:43:44 INFO - 'TMOUT': '86400', 14:43:44 INFO - 'USER': 'cltbld', 14:43:44 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882', 14:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:44 INFO - '_': '/tools/buildbot/bin/python'} 14:43:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:43:44 INFO - Cleaning up... 14:43:44 INFO - Return code: 0 14:43:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:43:44 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:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:44 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:43:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:44 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 0x15d21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1870310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186d400>, '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 0x186e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186e840>, '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': '2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882', '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:43:44 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:43:44 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:43:44 INFO - Using env: {'DISPLAY': ':0', 14:43:44 INFO - 'HOME': '/home/cltbld', 14:43:44 INFO - 'LANG': 'en_US.UTF-8', 14:43:44 INFO - 'LANGUAGE': 'en_US:en', 14:43:44 INFO - 'LOGNAME': 'cltbld', 14:43:44 INFO - 'MAIL': '/var/mail/cltbld', 14:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:44 INFO - 'MOZ_NO_REMOTE': '1', 14:43:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:44 INFO - 'NO_EM_RESTART': '1', 14:43:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:44 INFO - 'PWD': '/builds/slave/test', 14:43:44 INFO - 'SHELL': '/bin/bash', 14:43:44 INFO - 'SHLVL': '1', 14:43:44 INFO - 'TERM': 'linux', 14:43:44 INFO - 'TMOUT': '86400', 14:43:44 INFO - 'USER': 'cltbld', 14:43:44 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882', 14:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:44 INFO - '_': '/tools/buildbot/bin/python'} 14:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:45 INFO - Downloading/unpacking blobuploader==1.2.4 14:43:45 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:43:45 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:43:45 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:43:45 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:43:45 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:43:45 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:43:47 INFO - Downloading blobuploader-1.2.4.tar.gz 14:43:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:43:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:43:47 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:43:47 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:43:47 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:43:47 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:43:47 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:43:47 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:43:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:43:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:43:47 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:43:47 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:43:47 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:43:47 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:43:47 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:43:47 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:43:47 INFO - Downloading docopt-0.6.1.tar.gz 14:43:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:43:47 INFO - Installing collected packages: blobuploader, requests, docopt 14:43:47 INFO - Running setup.py install for blobuploader 14:43:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:43:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:43:48 INFO - Running setup.py install for requests 14:43:48 INFO - Running setup.py install for docopt 14:43:48 INFO - Successfully installed blobuploader requests docopt 14:43:48 INFO - Cleaning up... 14:43:48 INFO - Return code: 0 14:43:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:43: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:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43: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:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:48 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 0x15d21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1870310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186d400>, '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 0x186e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186e840>, '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': '2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882', '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:43:48 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:43:48 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:43:48 INFO - Using env: {'DISPLAY': ':0', 14:43:48 INFO - 'HOME': '/home/cltbld', 14:43:48 INFO - 'LANG': 'en_US.UTF-8', 14:43:48 INFO - 'LANGUAGE': 'en_US:en', 14:43:48 INFO - 'LOGNAME': 'cltbld', 14:43:48 INFO - 'MAIL': '/var/mail/cltbld', 14:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:48 INFO - 'MOZ_NO_REMOTE': '1', 14:43:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:48 INFO - 'NO_EM_RESTART': '1', 14:43:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:48 INFO - 'PWD': '/builds/slave/test', 14:43:48 INFO - 'SHELL': '/bin/bash', 14:43:48 INFO - 'SHLVL': '1', 14:43:48 INFO - 'TERM': 'linux', 14:43:48 INFO - 'TMOUT': '86400', 14:43:48 INFO - 'USER': 'cltbld', 14:43:48 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882', 14:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:48 INFO - '_': '/tools/buildbot/bin/python'} 14:43:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:43:48 INFO - Running setup.py (path:/tmp/pip-oFJQWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:43:48 INFO - Running setup.py (path:/tmp/pip-DGHhYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:43:48 INFO - Running setup.py (path:/tmp/pip-VUiBjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:43:49 INFO - Running setup.py (path:/tmp/pip-cvtomg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:43:49 INFO - Running setup.py (path:/tmp/pip-aZZyJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:43:49 INFO - Running setup.py (path:/tmp/pip-kYyC_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:43:49 INFO - Running setup.py (path:/tmp/pip-mq3BD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:43:49 INFO - Running setup.py (path:/tmp/pip-lStKJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:43:49 INFO - Running setup.py (path:/tmp/pip-NOk94N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:43:49 INFO - Running setup.py (path:/tmp/pip-Xb4uCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:43:49 INFO - Running setup.py (path:/tmp/pip-Fa4eew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:43:49 INFO - Running setup.py (path:/tmp/pip-PyX3Y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:43:49 INFO - Running setup.py (path:/tmp/pip-4tBVAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:43:49 INFO - Running setup.py (path:/tmp/pip-SL_wsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:49 INFO - Running setup.py (path:/tmp/pip-yo1K6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:43:49 INFO - Running setup.py (path:/tmp/pip-00UmBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:43:49 INFO - Running setup.py (path:/tmp/pip-rKAlA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:43:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:43:50 INFO - Running setup.py install for manifestparser 14:43:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:43:50 INFO - Running setup.py install for mozcrash 14:43:50 INFO - Running setup.py install for mozdebug 14:43:50 INFO - Running setup.py install for mozdevice 14:43:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:43:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:43:50 INFO - Running setup.py install for mozfile 14:43:50 INFO - Running setup.py install for mozhttpd 14:43:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:43:50 INFO - Running setup.py install for mozinfo 14:43:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:43:50 INFO - Running setup.py install for mozInstall 14:43:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:43:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:43:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:43:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:43:50 INFO - Running setup.py install for mozleak 14:43:50 INFO - Running setup.py install for mozlog 14:43:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:43:51 INFO - Running setup.py install for moznetwork 14:43:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:43:51 INFO - Running setup.py install for mozprocess 14:43:51 INFO - Running setup.py install for mozprofile 14:43:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:43:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:43:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:43:51 INFO - Running setup.py install for mozrunner 14:43:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:43:51 INFO - Running setup.py install for mozscreenshot 14:43:51 INFO - Running setup.py install for moztest 14:43:51 INFO - Running setup.py install for mozversion 14:43:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:43:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:43:51 INFO - Cleaning up... 14:43:51 INFO - Return code: 0 14:43:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:51 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 0x15d21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1870310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186d400>, '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 0x186e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186e840>, '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': '2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882', '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:43:51 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:43:51 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:43:51 INFO - Using env: {'DISPLAY': ':0', 14:43:51 INFO - 'HOME': '/home/cltbld', 14:43:51 INFO - 'LANG': 'en_US.UTF-8', 14:43:51 INFO - 'LANGUAGE': 'en_US:en', 14:43:51 INFO - 'LOGNAME': 'cltbld', 14:43:51 INFO - 'MAIL': '/var/mail/cltbld', 14:43:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:51 INFO - 'MOZ_NO_REMOTE': '1', 14:43:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:51 INFO - 'NO_EM_RESTART': '1', 14:43:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:51 INFO - 'PWD': '/builds/slave/test', 14:43:51 INFO - 'SHELL': '/bin/bash', 14:43:51 INFO - 'SHLVL': '1', 14:43:51 INFO - 'TERM': 'linux', 14:43:51 INFO - 'TMOUT': '86400', 14:43:51 INFO - 'USER': 'cltbld', 14:43:51 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882', 14:43:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:51 INFO - '_': '/tools/buildbot/bin/python'} 14:43:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:43:52 INFO - Running setup.py (path:/tmp/pip-hoSaYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:43:52 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:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:43:52 INFO - Running setup.py (path:/tmp/pip-p_bTkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:43:52 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:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:43:52 INFO - Running setup.py (path:/tmp/pip-3WBbqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:43:52 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:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:43:52 INFO - Running setup.py (path:/tmp/pip-ZfftRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:43:52 INFO - Running setup.py (path:/tmp/pip-ZwNxGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:43:52 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:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:43:52 INFO - Running setup.py (path:/tmp/pip-T310rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:43:52 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:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:43:52 INFO - Running setup.py (path:/tmp/pip-gR9EeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:43:52 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:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:43:52 INFO - Running setup.py (path:/tmp/pip-KJHHY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:43:52 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:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:43:52 INFO - Running setup.py (path:/tmp/pip-WniFWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:43:52 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:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:43:52 INFO - Running setup.py (path:/tmp/pip-Sgr8av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:43:52 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:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:43:52 INFO - Running setup.py (path:/tmp/pip-DnDa6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:43:52 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:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:43:52 INFO - Running setup.py (path:/tmp/pip-Edefq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:43:52 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:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:43:52 INFO - Running setup.py (path:/tmp/pip-kTScb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:43:53 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:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:43:53 INFO - Running setup.py (path:/tmp/pip-Dc2kr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:43:53 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:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:53 INFO - Running setup.py (path:/tmp/pip-vj5bT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:53 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:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:43:53 INFO - Running setup.py (path:/tmp/pip-W6wSKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:43:53 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:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:43:53 INFO - Running setup.py (path:/tmp/pip-w0xrJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:43:53 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:43:53 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:43:53 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:43:53 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:43:53 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:43:53 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:43:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:43:53 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:43:53 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:43:53 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:43:53 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:43:53 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:43:53 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:43:55 INFO - Downloading blessings-1.6.tar.gz 14:43:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:43:55 INFO - Installing collected packages: blessings 14:43:55 INFO - Running setup.py install for blessings 14:43:55 INFO - Successfully installed blessings 14:43:55 INFO - Cleaning up... 14:43:55 INFO - Return code: 0 14:43:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:43:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:43:55 INFO - Reading from file tmpfile_stdout 14:43:55 INFO - Current package versions: 14:43:55 INFO - argparse == 1.2.1 14:43:55 INFO - blessings == 1.6 14:43:55 INFO - blobuploader == 1.2.4 14:43:55 INFO - docopt == 0.6.1 14:43:55 INFO - functools32 == 3.2.3-2 14:43:55 INFO - jsonschema == 2.5.1 14:43:55 INFO - manifestparser == 1.1 14:43:55 INFO - mozInstall == 1.12 14:43:55 INFO - mozcrash == 1.0 14:43:55 INFO - mozdebug == 0.1 14:43:55 INFO - mozdevice == 0.49 14:43:55 INFO - mozfile == 1.2 14:43:55 INFO - mozhttpd == 0.7 14:43:55 INFO - mozinfo == 0.9 14:43:55 INFO - mozleak == 0.1 14:43:55 INFO - mozlog == 3.4 14:43:55 INFO - moznetwork == 0.27 14:43:55 INFO - mozprocess == 0.25 14:43:55 INFO - mozprofile == 0.28 14:43:55 INFO - mozrunner == 6.13 14:43:55 INFO - mozscreenshot == 0.1 14:43:55 INFO - mozsystemmonitor == 0.3 14:43:55 INFO - moztest == 0.8 14:43:55 INFO - mozversion == 1.4 14:43:55 INFO - psutil == 3.1.1 14:43:55 INFO - requests == 1.2.3 14:43:55 INFO - wsgiref == 0.1.2 14:43:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:55 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 0x15d21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1870310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186d400>, '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 0x186e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186e840>, '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': '2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882', '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:43:55 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:43:55 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:43:55 INFO - Using env: {'DISPLAY': ':0', 14:43:55 INFO - 'HOME': '/home/cltbld', 14:43:55 INFO - 'LANG': 'en_US.UTF-8', 14:43:55 INFO - 'LANGUAGE': 'en_US:en', 14:43:55 INFO - 'LOGNAME': 'cltbld', 14:43:55 INFO - 'MAIL': '/var/mail/cltbld', 14:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:55 INFO - 'MOZ_NO_REMOTE': '1', 14:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:55 INFO - 'NO_EM_RESTART': '1', 14:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:55 INFO - 'PWD': '/builds/slave/test', 14:43:55 INFO - 'SHELL': '/bin/bash', 14:43:55 INFO - 'SHLVL': '1', 14:43:55 INFO - 'TERM': 'linux', 14:43:55 INFO - 'TMOUT': '86400', 14:43:55 INFO - 'USER': 'cltbld', 14:43:55 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882', 14:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:55 INFO - '_': '/tools/buildbot/bin/python'} 14:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:56 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:43:56 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:43:56 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:43:56 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:43:56 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:43:56 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:43:56 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:43:56 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:43:56 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:43:56 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:43:56 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:43:56 INFO - Cleaning up... 14:43:56 INFO - Return code: 0 14:43:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:43: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:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43: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:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:56 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 0x15d21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1870310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186d400>, '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 0x186e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186e840>, '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': '2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882', '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:43:56 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:43:56 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:43:56 INFO - Using env: {'DISPLAY': ':0', 14:43:56 INFO - 'HOME': '/home/cltbld', 14:43:56 INFO - 'LANG': 'en_US.UTF-8', 14:43:56 INFO - 'LANGUAGE': 'en_US:en', 14:43:56 INFO - 'LOGNAME': 'cltbld', 14:43:56 INFO - 'MAIL': '/var/mail/cltbld', 14:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:56 INFO - 'MOZ_NO_REMOTE': '1', 14:43:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:56 INFO - 'NO_EM_RESTART': '1', 14:43:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:56 INFO - 'PWD': '/builds/slave/test', 14:43:56 INFO - 'SHELL': '/bin/bash', 14:43:56 INFO - 'SHLVL': '1', 14:43:56 INFO - 'TERM': 'linux', 14:43:56 INFO - 'TMOUT': '86400', 14:43:56 INFO - 'USER': 'cltbld', 14:43:56 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882', 14:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:56 INFO - '_': '/tools/buildbot/bin/python'} 14:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:43:56 INFO - Cleaning up... 14:43:56 INFO - Return code: 0 14:43:56 INFO - Running post-action listener: _resource_record_post_action 14:43:56 INFO - Running post-action listener: _start_resource_monitoring 14:43:56 INFO - Starting resource monitoring. 14:43:56 INFO - [mozharness: 2017-03-16 21:43:56.305680Z] Finished create-virtualenv step (success) 14:43:56 INFO - [mozharness: 2017-03-16 21:43:56.306248Z] Running install step. 14:43:56 INFO - Running pre-action listener: _resource_record_pre_action 14:43:56 INFO - Running main action method: install 14:43:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:43:56 INFO - Reading from file tmpfile_stdout 14:43:56 INFO - Detecting whether we're running mozinstall >=1.0... 14:43:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:43:56 INFO - Reading from file tmpfile_stdout 14:43:56 INFO - Output received: 14:43:56 INFO - Usage: mozinstall [options] installer 14:43:56 INFO - Options: 14:43:56 INFO - -h, --help show this help message and exit 14:43:56 INFO - -d DEST, --destination=DEST 14:43:56 INFO - Directory to install application into. [default: 14:43:56 INFO - "/builds/slave/test"] 14:43:56 INFO - --app=APP Application being installed. [default: firefox] 14:43:56 INFO - mkdir: /builds/slave/test/build/application 14:43:56 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:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:44:13 INFO - Reading from file tmpfile_stdout 14:44:13 INFO - Output received: 14:44:13 INFO - /builds/slave/test/build/application/firefox/firefox 14:44:13 INFO - Running post-action listener: _resource_record_post_action 14:44:13 INFO - [mozharness: 2017-03-16 21:44:13.286588Z] Finished install step (success) 14:44:13 INFO - [mozharness: 2017-03-16 21:44:13.286866Z] Running run-tests step. 14:44:13 INFO - Running pre-action listener: _resource_record_pre_action 14:44:13 INFO - Running main action method: run_tests 14:44:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:44:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:44:13 INFO - Python 2.7.3 14:44:13 INFO - Return code: 0 14:44:13 INFO - grabbing minidump binary from tooltool 14:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:44:13 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 0x186d400>, '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 0x186e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186e840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:44:13 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:44:13 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:44:13 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:44:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:44:13 INFO - Return code: 0 14:44:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:44:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:44:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:44:13 INFO - ENV: RUST_BACKTRACE is now 1 14:44:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:44:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:44:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:44:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-070 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:44:13 INFO - Using env: {'DISPLAY': ':0', 14:44:13 INFO - 'HOME': '/home/cltbld', 14:44:13 INFO - 'LANG': 'en_US.UTF-8', 14:44:13 INFO - 'LANGUAGE': 'en_US:en', 14:44:13 INFO - 'LOGNAME': 'cltbld', 14:44:13 INFO - 'MAIL': '/var/mail/cltbld', 14:44:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:44:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:13 INFO - 'MOZ_NO_REMOTE': '1', 14:44:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:44:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:44:13 INFO - 'NO_EM_RESTART': '1', 14:44:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:13 INFO - 'PWD': '/builds/slave/test', 14:44:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:44:13 INFO - 'RUST_BACKTRACE': '1', 14:44:13 INFO - 'SHELL': '/bin/bash', 14:44:13 INFO - 'SHLVL': '1', 14:44:13 INFO - 'TERM': 'linux', 14:44:13 INFO - 'TMOUT': '86400', 14:44:13 INFO - 'USER': 'cltbld', 14:44:13 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882', 14:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:13 INFO - '_': '/tools/buildbot/bin/python'} 14:44:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:44:13 INFO - mozversion application_buildid: 20170316204800 14:44:13 INFO - mozversion application_changeset: 39607304b774591fa6e32c4b06158d869483c312 14:44:13 INFO - mozversion application_display_name: Nightly 14:44:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:44:13 INFO - mozversion application_name: Firefox 14:44:13 INFO - mozversion application_remotingname: firefox 14:44:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:44:13 INFO - mozversion application_vendor: Mozilla 14:44:13 INFO - mozversion application_version: 55.0a1 14:44:13 INFO - mozversion platform_buildid: 20170316204800 14:44:13 INFO - mozversion platform_changeset: 39607304b774591fa6e32c4b06158d869483c312 14:44:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:44:13 INFO - mozversion platform_version: 55.0a1 14:44:13 INFO - using testdate: 1489700653 14:44:13 INFO - actual date: 1489700653 14:44:13 INFO - starting webserver on 'localhost:44847' 14:44:13 INFO - SUITE-START | Running 2 tests 14:44:13 INFO - TEST-START | dromaeo_css 14:44:13 INFO - operating with platform_type : linux_ 14:44:13 INFO - Initialising browser for dromaeo_css test... 14:44:13 INFO - TEST-INFO | started process 28345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT79x7c/profile http://localhost:44847/getInfo.html) 14:44:17 INFO - PID 28345 | __metrics Screen width/height:1600/1200 14:44:17 INFO - PID 28345 | colorDepth:24 14:44:17 INFO - PID 28345 | Browser inner width/height: 1024/697 14:44:17 INFO - PID 28345 | __metrics 14:44:18 INFO - PID 28345 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:44:18 INFO - PID 28345 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:44:19 INFO - TEST-INFO | 28345: exit 0 14:44:19 INFO - Browser initialized. 14:44:19 INFO - Running cycle 1/1 for dromaeo_css test... 14:44:19 INFO - TEST-INFO | started process 28437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT79x7c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:44:31 INFO - PID 28437 | RSS: Main: 144257024 14:44:31 INFO - PID 28437 | 14:47:32 INFO - PID 28437 | Cycle 1(1): loaded http://localhost:44847/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44847/tests/dromaeo/cssquery-ext.html) 14:47:33 INFO - PID 28437 | RSS: Main: 259899392 14:47:33 INFO - PID 28437 | 14:49:20 INFO - PID 28437 | ************************* 14:49:20 INFO - PID 28437 | A coding exception was thrown and uncaught in a Task. 14:49:20 INFO - PID 28437 | 14:49:20 ERROR - PID 28437 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:49:20 INFO - PID 28437 | Full stack: 14:49:20 INFO - PID 28437 | ************************* 14:50:36 INFO - PID 28437 | Cycle 1(1): loaded http://localhost:44847/tests/dromaeo/cssquery-ext.html (next: http://localhost:44847/tests/dromaeo/cssquery-jquery.html) 14:50:36 INFO - PID 28437 | RSS: Main: 232636416 14:50:36 INFO - PID 28437 | 14:53:38 INFO - PID 28437 | Cycle 1(1): loaded http://localhost:44847/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44847/tests/dromaeo/cssquery-mootools.html) 14:53:39 INFO - PID 28437 | RSS: Main: 242122752 14:53:39 INFO - PID 28437 | 14:56:41 INFO - PID 28437 | Cycle 1(1): loaded http://localhost:44847/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44847/tests/dromaeo/cssquery-prototype.html) 14:56:41 INFO - PID 28437 | RSS: Main: 178049024 14:56:41 INFO - PID 28437 | 14:59:44 INFO - PID 28437 | Cycle 1(1): loaded http://localhost:44847/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44847/tests/dromaeo/cssquery-yui.html) 14:59:45 INFO - PID 28437 | RSS: Main: 183500800 14:59:45 INFO - PID 28437 | 15:02:48 INFO - PID 28437 | Cycle 1(1): loaded http://localhost:44847/tests/dromaeo/cssquery-yui.html (next: http://localhost:44847/tests/dromaeo/cssquery-dojo.html) 15:02:48 INFO - PID 28437 | RSS: Main: 275120128 15:02:48 INFO - PID 28437 | 15:02:48 INFO - PID 28437 | __start_tp_report 15:02:48 INFO - PID 28437 | _x_x_mozilla_page_load 15:02:48 INFO - PID 28437 | _x_x_mozilla_page_load_details 15:02:48 INFO - PID 28437 | |i|pagename|runs| 15:02:48 INFO - PID 28437 | |0;dojo.html;3131.4989601663733;3207.871685132595;3233.2401885556906;3236.983815080925;3258.918527036824;5386.676799392039;5482.80810171644;5484.396716361197;5521;5555.277813884194;5501.284832971718;5527.2538207341995;5532.2531458253125;5534.557235421166;5542.612017158801;4961.652684312091;4966;4992.825251116212;5000;5047.26814611881;5025.522575355335;5097.464766199551;5113.51421614946;5140.33175687162;5140.563052140554;5083.085044691954;5109.514596113363;5109.846704598868;5131.1277082895995;5155.639105262633;424.0526914945516;4518.932216016762;4990.850274491735;4991.675541089818;5088.567471764904;4987.102321582114;4989.57588604969;5009.849704508834;5027.069992051483;5040.873978150539;5550.333959924795;5601.327840659106;5605.299337582802;5609.158626206061;5614.719264036782;5841.065429531254;5915.5859089863725;6064.332923378425;6066.302375226861;6072.332043475214;5851.970740146315;5937.435943585352;5951.732172052268;5978.3124940631515;6002.54980876436;5587.7485513152005;5592.944070559283;5601.523870471015;5607.859803504904;5611.494965453088;6134.8159555213415;6136.417040381246;6138.14066030756;6138.447539721446;6143.877122457526;5696.715164241771;5710.457506536873;5770.653760774367;5786.566007549366;5849.678267695318;5967.194428752063;5976.163337132805;5983.042713165873;5986.07215881539;6039.275286965592;5792.478676919013;5880.588358814927;5883.911741323884;5920.4967577755515;5928.851778705567;5912.615679980788;5929.080992446177;5930.970345148246;5952.5833191676165;5991.5206783457215;4484.282514797616;4506.977465112719;4525.615322697542;4539.682222244412;4548.931766023512;4036.616521430459;4064.4919385076864;4070.063885306396;4090.4886889138857;4108.958910410917;5590.18942253371;5592.832215033555;5594.300712410949;5597.524210442158;5600.6919619420505;5824.446677565625;5901.0558310670085;6010.098485227163;6010.278766548042;6019.69901504923;5565.693886836263;5580.19087232349;5620.409856965041;5621.522170615462;5625.521830644441;5067.46791586878;5071.315372424676;5073.162928116893;5074.543291103744;5120.743962801845;6075.483583895419;6145.723442445012;6154.107654390088;6155;6155.507559395238;5944.613600115978;5974.641521508724;6048.304444988883;6048.425399587032;6059.0608455689435;6131.448169664752;6144.518437531025;6152.876942461216;6188.690565471798;6192.102145189013;5886.705664716833;5894.852628684317;5896.7936122235515;5904.911426328523;5914.112883067574;5853.2390789198835;5905.143754155538;5975.940240597538;6052.001419765689;6060.39396060408;5845.8538536535225;5847.678377689268;5849.0933905243055;5850.678212698343;5881.705914704162;5686.374498805211;5839.824805255679;5845.853853653693;5846.532277417711;5852.707364631666;5718.1708652246025;5737.48362647347;5768.163616275533;5823.79616713413;5838.036723940502;5834.299884013945;5871.588988770745;5872.853178670567;5880.470757631662;5896.823095307148;5640.294963129609;5643.548516118619;5693.772249109989;5695.174199741097;5699.971500142473 15:02:48 INFO - PID 28437 | |1;ext.html;591.2786400591277;639.8624295776407;656.0421784195073;766.961651917404;775.7440044785221;29749.702502974964;36415.453768193496;37476.06309842252;37689.434658480146;37868.24263514728;39362.8031859841;39823.20353592934;39888.60111398885;43582.78208608952;43722.781386093106;7131.928680713178;8911.777205569864;9144.085591440837;9144.634214631407;9149.542522873862;7290.890636640454;10080;10297.691069267934;10298.227632927523;10305.690829275096;10410.553519922812;10457.163426925828;10493.317934334282;10504.579816807318;10519.947400262989;10706.304090234109;10710.839337409945;10778.083862871705;10804.243702940797;10820.78358432827;10168.237382196365;10227.18182545402;10238.436885971269;10254.282200245985;10258.435786031765;41348.58651413507;41653.375199372036;41723.79138104321;41755.58244417578;41783.79108104471;3501.2822371414054;3509.157802127471;3555.182308069133;3578.1054736315923;3584.17563960288;28455.288617784514;28897.855510722522;28955;28973.42053158946;28996.420071598663;4155.127423241123;4208.768517731523;4220.345846393814;4438.644908407319;4440.200763862504;219801;221242;221366;221552;221660;42813.571864281585;43022.784886075366;43201.351979720326;43613;43618.7819060909;52947.205791913155;52967.735161324716;53062;53079.734601326745;53123.46876531185;15351.923240383727;15479.380824766884;15492.612684682748;15494.14782186968;15501.612459688373;10659.307145035547;10891.292066015683;12553.686157846127;12644.30456324911;12661.430235639418;11471;11542.480588373543;11634.6509604712;11715.76568468626;11718.824217636742;4740.525947405232;4802.255650374198;4817.78319975602;4849.709017458964;4902.828401005948;781.2656103262915;802.2058162419163;814.5031530766228;820.8481430935177;840.6175190288526;23039;23753.52492950166;23972.160974365812;24083.51832963331;24087.75912240855;850.8340873529602;866.3805379153936;868.7914900423852;871.9738407847775;893.0578239956778;12198.817017744741;12575;12716.745665086646;12726.618201453972;12855.742885142432;243601;245370;295111;296809;297172;48601.75699121482;49340.753296234005;49624;49644.50355496471;49710.25434618411;1168.2990205876406;1210.922279171538;1211.6183402228446;1211.9697007574882;1223.804191329383;26380.340491487867;27611.44777104487;28677.713222867504;30669.693303067575;30860.382792344477;49204.753976231324;49548.25677614767;49708.502914970384;49735.75132124316;49936.75031624819;254804;256754;257169;257316;257605;28481.572776407957;28628.42743145167;28790.856045719636;28857.567136493388;28918.42163156767;33636.66363336335;34078.318433631684;34647.84225892909;34660.48009279913;34813.82593087018;29179.41641167207;29333;29333.26666833346;29725.256868577595;30079.6464159109;28767.71232287734;28790.568141477477;29473.410531789672;29588.260293492836;29923;30205.395892082473;30943;30997.69002309948;31080.68919310778;31091;26561;26884;26986.1904142876;27635.833037673186;27760.167194984184;22016.669749953442;22028;22112.2260720874;22221.888890555445;22346 15:02:48 INFO - PID 28437 | |2;jquery.html;389.213788147941;406.3275279412573;414.169589972106;429.25738472442674;429.3859780513866;14011.719765604681;15749;19786.208551657917;20030.399088027345;21190.682139767916;18842.34051808187;19038.33365832196;19565.119569619364;19577.60844783107;19886.10512526936;6104.633721976674;6325.746970121189;6495.155629768147;6553.115329430538;6611.504137189706;4133.73130746502;4352.825886964518;6436.967815160941;6566.967165164191;6579.078928949927;6971.58170509771;7298.270172982686;7304.890426643605;7322.414206863465;7351.411887049023;7467.439942004345;7482.102147742278;7790.298873101448;7818.413618978542;7820.296173344369;7275.563466191992;7380.335769780745;7475.9252407476315;7620.161782203953;7643.847123057563;25872.223833284843;26173;26445.206643800717;27165;28357.858210708815;2971.435427268834;3037.1951432870305;3111.2377467520378;3122.9063128106195;3151.2121969507625;15822.129782861937;16128.83871161285;16936.576585585335;16976.405825796162;17777.911110444493;2141.7215761951;2219.6670499425054;2247.6179049561615;2263.0155882191298;2289.2331069091874;110609.44695276472;112811.43594282058;113541.43229283801;113793;116040;19659.508512287022;20509.48726281825;20522.022512345575;20856;21180.470488237916;35034.82482587571;35415.64584354175;35586;35653.46519802205;35776;9905.455199964072;10286.845697314397;10397.84403233952;10495.895041049644;10637.521311540999;8109.107998120202;8175.591220438954;8221.301189398848;8396.916030839735;8488.363372747068;9890.554925028391;10080.14318782897;10270.383776973256;10292.382457052601;10356.223283253636;3493.589263701086;3531.5585551806025;3594.6045934947133;3705.40713485841;3770.773753574739;878.8242351529719;893.3612467085935;917.9541022948825;925.500229875873;930.9441433514011;21976.780232197794;22939.19712810077;23254.418639533807;23298.417539561648;23319.53360932772;824.1305422778906;827.6896163938524;830.1197787012421;830.1698301698302;832.9416940814085;12033.157678962563;12488.740027770531;12544.556624250796;12617.242965422103;12745.36273186337;572405;595363;605275;631954;632848;77710;78278.21721782823;109372;110906;113522.459101635;1073.468633026641;1077.73595469109;1087.4508373271447;1094.2777766673958;1099.3623698254994;17211.741823872904;17263.654726905643;17866.76665416823;17925.28298868031;18182.72725909139;48603.11175105912;49154.262686059024;50035;50246;50763.238551422495;65214.34785652273;65400.67299663471;65955.67022164859;65966.67016664887;67746.66126669335;8480.61837217339;11505.942470287595;13021.674458138243;13342.533011344556;13645.249511276976;14014.929925350309;14503.78244326357;14732.631684207981;15178;15216.847831521543;12891.226526408445;12948.935255323662;13044;13220.338983051;13447.663808404868;11872.872077152657;12523.436445360163;12571.622851314476;12617.36913154357;12868.871311286768;12875.291858947849;12911.5480958166;13086.672833179247;13110.213387196798;13116.803247951097;13184.40670169864;13199.868001320248;13208.471661133448;13235.40440680191;13273.601791946257;12542;12627.621171364874;12729;12773.48906043785;12790.104692671795 15:02:48 INFO - PID 28437 | |3;mootools.html;1443.9205843678606;1481.1853480585676;1497.625593601599;1516.317657054325;1534.608674787929;9879.308448408614;10216;10230.670012898332;10233.232507561925;10236.948815255922;10029.648962286321;10177.08406243438;10425.843612345821;10458.320209186397;10466.162706983441;2024.3623258673508;2051.2923041550716;2067.7208576842086;2068.1727309076414;2073;1979;2004.7794742578305;2009.6985452182143;2022.6460369435363;2030.4619275891826;1978.6636271833822;1982.1476764991048;2007.5382661987678;2009;2012.376163389354;1967.2721093195537;1975.051975051976;1975.4666240115089;1976.3379267945184;1977.3178253502663;1957.9706304405445;1960.5098725318671;1993.6810110382414;2008.347287131688;2009.156154415149;10613.946930265376;10683.572657093708;10706.41114738689;10708.46457677113;10709.143268538499;4946.950530494685;5091.46539613339;5098.337216161913;5102.540771330598;5102.821401250975;2918.357961248522;3117.2051126962706;3167.7307428868576;3175.8249447704497;3182.0931034655246;1196.2583198417037;1208.7159517513378;1213.915025948184;1223.892377398456;1317.295247042837;13413.932930335384;13790.172589644653;14289.857101429061;15582;15829.129397883113;3878.7090968176935;3914.0606254498716;4033.052232725307;4103.7742924138865;4107.97946010274;11614.825777613343;11718.06255499558;11724.531018759155;11762.059035277158;11765.705857353634;5071.264666623319;5076.0863044652315;5077.517635824591;5080.212567052039;5088.084144853888;4585.151746926829;4628.884277893079;4658.976705116521;4681;4718.292256161603;3299.5215693724276;3315.668433156665;3363.081632247417;3374.54443650109;3404.914877128042;895.0914821456228;896.789254525186;903.7966457547;915.6840889893109;917.8347897378536;805.4040010392267;815.2133191470259;816.3061397811813;819.663937785505;824.1634740738156;5726.539732368219;5856.970715146397;5873.647581145145;5949.2266005419015;6137.079438084323;890.5858775669345;897.9146981036791;905.1446383167843;908.0919080919081;908.096444038173;3667.7982710951155;3761.652129604654;3829.1384438501673;3837.4819399381286;3856.537215534154;12713;13264.867351326557;13280.335983200801;13347.933260333637;13389.464421423228;13187.73624527504;13213.88577827543;13325.200487970753;13374.799378009338;13382.197068175941;9665.516724163623;9695.272854535939;9766.951165244129;9808.950955245178;9810.362326448902;5700.686462244616;5753.165790960371;5777.104548794943;5793.1903027032695;5856;11533.88466115328;11647.708807279547;11671.183017188716;11802.704932376415;11860.703482413008;12133.939330303292;12252.264864108181;12263.202891812003;12439;12449.564265250672;8101.149379315087;8151.79620509492;8246.917530824854;8250.669973201006;8255.876161857697;9432.52837358143;9442.811143777224;9494.620215191591;9515.619375225191;9579.568919398504;8573.356998225034;8586.141385861614;8627.87058194115;8630.5253211074;8665.350098742745;8178.46839955401;8338.749837504885;8382.958085209535;8479.32165426752;8564.614592343234;7138.214796372498;7158.105236845395;7284.49008569395;7293.744718934812;7295.598742069237;5256.448072952285;5281.287026251407;5334.573234141337;5347.1979203119845;5401.648892821954;5456.427075157051;5459.818635095015;5491.780328786964;5632.043177331933;5634.408387119293 15:02:48 INFO - PID 28437 | |4;prototype.html;395.69729157194735;403.1372862075158;406.84539874847553;411.37471044013097;412.4576182320248;5696.544276457884;5756.136579513065;5775.3358363788175;5780.884382312352;5784.13238014297;5540.3628582713;5581.553475721943;5663.461971112738;5678.772849086042;5710.942890571093;4449.88875278119;4486.3046227834575;4495.393121928547;4502.864914052584;4507.6168525675275;4473.82104715811;4487.708298960573;4496.010877606921;4503.819847206108;4504.504504504502;4498.707584007046;4501.459824821026;4683.437987441512;4716.2218233991525;4730.385049943503;4623.56076172763;4644.187267228222;4693.812247510095;4696.248600223965;4698.4361876574685;4355.237833379146;4361.803718832628;4366.8034938427845;4389.2318844202455;4412.75729834859;5365;5482.588805839578;5482.945170548323;5524.806631767869;5547.308071038332;5517.200005999108;5527.613067085305;5532.917006244909;5549.6115271930985;5556.749946252428;5797.507211886995;6028.246469191351;6054.697265136726;6072.180255665517;6074.908876366858;4853.975730121362;4857.902841943177;4871.464138944713;4872.561469467765;4906.165951788204;6017;6192.504599632064;6246.781362652286;6301.905471417932;6326.4377926939205;4914.140025495524;5035.723035233097;5076.619253555924;5082.872928176751;5086.949130508648;5152.5362717354865;5164.509371609691;5164.845054648366;5169.896602067937;5172;5463.6554362581755;5482.945170548243;5509.696966666792;5521.641093328921;5544.22380866679;6002.789902353396;6007.369226231182;6008.279006519246;6013.218281623361;6017.277926648742;1764.303100275384;1770.5485101299344;1799.6580649676519;1799.8920064796155;1806.4219449776208;1327.4889167670324;1332.0478514087886;1354.0048064672458;1366.6719987203;1371.5268232459784;5802.854928626733;5803.100519419497;5805;5809.883802324014;5811.0992796115825;6140.631562106288;6181.412765787243;6191.690415479208;6196.318404975449;6234.625922444668;5513.145462453326;5668.659880407106;5726.685032323262;5726.9713651431475;5751.281089863767;3277.1807048237943;3299.9835000825324;3300.9834950825093;3303.487959366302;3314.171457135716;6169.475594574512;6359.632678974042;6362.968185159045;6407.647579383085;6416.165898433267;6310.495160387158;6366.522510811707;6379.744810207632;6388.520860935449;6396.0725694774;6441;6451.516136289797;6470.870582588322;6474.579152355176;6491.675416229265;6063.454289114001;6148.846278843064;6170.228721409824;6173.59871608344;6183.938160618336;5820.679862607428;6117.113018612187;6135.478484328703;6138.508919286535;6157.630542167484;6214;6284.4344009039405;6435.2599451063725;6464.353564643498;6471.805845824632;5033.245013248042;5072.416672082758;5092.351976972028;5093.1341671915125;5097.464766199496;6071.7571297147615;6174.907376389448;6187.381261873957;6191.442770150708;6271.153394291712;6011.398860113954;6018.7291571878495;6022.1870047543025;6034.758609655741;6053.4551890330085;5857.384974577779;6025.457708806229;6052.788152414644;6058.394160583906;6063;5961.672108034099;5997.580169388101;6011;6028.2766068072115;6043.2748070231855;6011.428914253139;6040.161124271585;6054.182685337423;6085.2393450818645;6090.634561926298;5764.682942438206;5891.351951285269;5898.4101589840675;5908.793192238423;5909.55678324136 15:02:48 INFO - PID 28437 | |5;yui.html;664.7440735316901;686.2691233835963;688.5249178067135;689.6482793775176;695.0859619600222;16481.423150189745;16880.915595422022;16889.746653800205;16898.493045208663;16916.74624880625;14612.853871461282;14841.703165936675;14861.479848205288;14869.925650371733;14883.479078232263;783.2089589514575;800.5156880087551;810.5703976892227;826.5288785392329;830.0744669693279;833.4582521361103;833.9874901876477;834.3575446905879;834.7704381295132;835.2858306148247;879.1428357351595;879.3141349747208;880.0143838900441;882.483747008001;882.9646814127459;875.2735229759285;876.609908590671;876.8991565969867;877.0878286581947;877.1141147441067;639.5107742576886;640.0239634557291;641.425923798198;641.5252712992352;641.8940874755659;16911.154442277835;17221.311147554083;17336.913315433467;17422.825771742246;17430.12849357527;12937.15908465956;13378.732425351536;13439.86560134396;13440;13467.326633668376;11972.161948663597;12292.955098816612;12354.505819767199;12364.752704945851;12381.380930953506;3696.2237930034726;3701.38927077032;3723.2181241938956;3792.829322680486;3794.0894185395305;92363.56028453603;94049;94117.5294123525;94743.05256947411;95970.52014739881;10680.092192163598;10906.945465272782;10915.181361397927;10961.890381096087;11106.222564420576;25040.874795625907;25250.621240681405;25437.236882893543;25588.010337983913;25944.74055259461;8326.25063744266;8332.916670833336;8562.61468233931;8597.656093756304;8608.612612432456;4290.184864875664;4358.4769827620885;4401.955980440154;4442.20040392726;4460.8661740147845;3443.9827800860835;3520.1727594015388;3520.2783429396914;3523.9295214095573;3655.7623754455876;622.6326467384265;624.8063100438878;625.0993798696194;625.1622825413967;638.8307098618869;656.8916128838688;672.8183390484542;685.6263336481529;687.9862402751917;692.3526502719973;10119.66221237924;10239.232057595711;10304.690859274233;10477.161827053817;10549.9472502637;570.7460180219846;591.5740666719955;596.1058412381428;630.8517498387876;695.7564852301654;4355.259605867011;4841.782119804618;4865.125480274582;4966.106100901872;4976.975115124474;60690;68585.65707171432;72223.27776722271;79051.60474197593;81553.84461553796;65897.67051164714;66422.33577664258;66557;66913.33086669169;68545;55264.44735552673;59767.402325977055;60223;60351.39648603545;60743.69628151831;9742.853857192005;9956;9966.900330996597;10079.24405669563;10085.69742907714;40080.39879401753;41000.384994224514;41279.58720412757;41506;41984.790076050645;48101.316453923944;48139.277910830664;48287.309944151784;48950.26574601312;50804.491955079975;11017.61438349686;11094.79425779952;11169.664910052712;11226.438678066228;11460.197786155222;12693.873061269638;12903.483860645469;13073.346332683517;13200.273984930922;13213.801792973305;12541.686457838627;12611.68470788201;12624.990000800097;12778.361081945679;13274.933625332198;11448.313101213955;11572.768544629229;11951.282923024299;11965.162438629213;12452.066095043088;11683.18217724751;11911.642650720492;11940.283582985048;12371.566995155126;12398.81401778956;10095.236191751397;10764.246502745045;11130.387828669178;11225.214235003472;11254.155938304497;9834.901650983398;10579.312344697877;10614.097801686634;10643.254972151875;10688.519016644113 15:02:48 INFO - PID 28437 | __end_tp_report 15:02:48 INFO - PID 28437 | __start_cc_report 15:02:48 INFO - PID 28437 | _x_x_mozilla_cycle_collect,1202 15:02:48 INFO - PID 28437 | __end_cc_report 15:02:48 INFO - PID 28437 | __startTimestamp1489701768358__endTimestamp 15:02:48 INFO - PID 28437 | 15:02:48 INFO - PID 28437 | ------- Summary: start ------- 15:02:48 INFO - PID 28437 | Number of tests: 6 15:02:48 INFO - PID 28437 | 15:02:48 INFO - PID 28437 | [#0] dojo.html Cycles:165 Average:5494.17 Median:5710.46 stddev:749.63 (13.1%) stddev-sans-first:728.65 15:02:48 INFO - PID 28437 | Values: 3131.5 3207.9 3233.2 3237.0 3258.9 5386.7 5482.8 5484.4 5521.0 5555.3 5501.3 5527.3 5532.3 5534.6 5542.6 4961.7 4966.0 4992.8 5000.0 5047.3 5025.5 5097.5 5113.5 5140.3 5140.6 5083.1 5109.5 5109.8 5131.1 5155.6 424.1 4518.9 4990.9 4991.7 5088.6 4987.1 4989.6 5009.8 5027.1 5040.9 5550.3 5601.3 5605.3 5609.2 5614.7 5841.1 5915.6 6064.3 6066.3 6072.3 5852.0 5937.4 5951.7 5978.3 6002.5 5587.7 5592.9 5601.5 5607.9 5611.5 6134.8 6136.4 6138.1 6138.4 6143.9 5696.7 5710.5 5770.7 5786.6 5849.7 5967.2 5976.2 5983.0 5986.1 6039.3 5792.5 5880.6 5883.9 5920.5 5928.9 5912.6 5929.1 5931.0 5952.6 5991.5 4484.3 4507.0 4525.6 4539.7 4548.9 4036.6 4064.5 4070.1 4090.5 4109.0 5590.2 5592.8 5594.3 5597.5 5600.7 5824.4 5901.1 6010.1 6010.3 6019.7 5565.7 5580.2 5620.4 5621.5 5625.5 5067.5 5071.3 5073.2 5074.5 5120.7 6075.5 6145.7 6154.1 6155.0 6155.5 5944.6 5974.6 6048.3 6048.4 6059.1 6131.4 6144.5 6152.9 6188.7 6192.1 5886.7 5894.9 5896.8 5904.9 5914.1 5853.2 5905.1 5975.9 6052.0 6060.4 5845.9 5847.7 5849.1 5850.7 5881.7 5686.4 5839.8 5845.9 5846.5 5852.7 5718.2 5737.5 5768.2 5823.8 5838.0 5834.3 5871.6 5872.9 5880.5 5896.8 5640.3 5643.5 5693.8 5695.2 5700.0 15:02:48 INFO - PID 28437 | 15:02:48 INFO - PID 28437 | [#1] ext.html Cycles:180 Average:40799.08 Median:162349.63 stddev:65842.51 (40.6%) stddev-sans-first:65958.00 15:02:48 INFO - PID 28437 | Values: 591.3 639.9 656.0 767.0 775.7 29749.7 36415.5 37476.1 37689.4 37868.2 39362.8 39823.2 39888.6 43582.8 43722.8 7131.9 8911.8 9144.1 9144.6 9149.5 7290.9 10080.0 10297.7 10298.2 10305.7 10410.6 10457.2 10493.3 10504.6 10519.9 10706.3 10710.8 10778.1 10804.2 10820.8 10168.2 10227.2 10238.4 10254.3 10258.4 41348.6 41653.4 41723.8 41755.6 41783.8 3501.3 3509.2 3555.2 3578.1 3584.2 28455.3 28897.9 28955.0 28973.4 28996.4 4155.1 4208.8 4220.3 4438.6 4440.2 219801.0 221242.0 221366.0 221552.0 221660.0 42813.6 43022.8 43201.4 43613.0 43618.8 52947.2 52967.7 53062.0 53079.7 53123.5 15351.9 15479.4 15492.6 15494.1 15501.6 10659.3 10891.3 12553.7 12644.3 12661.4 11471.0 11542.5 11634.7 11715.8 11718.8 4740.5 4802.3 4817.8 4849.7 4902.8 781.3 802.2 814.5 820.8 840.6 23039.0 23753.5 23972.2 24083.5 24087.8 850.8 866.4 868.8 872.0 893.1 12198.8 12575.0 12716.7 12726.6 12855.7 243601.0 245370.0 295111.0 296809.0 297172.0 48601.8 49340.8 49624.0 49644.5 49710.3 1168.3 1210.9 1211.6 1212.0 1223.8 26380.3 27611.4 28677.7 30669.7 30860.4 49204.8 49548.3 49708.5 49735.8 49936.8 254804.0 256754.0 257169.0 257316.0 257605.0 28481.6 28628.4 28790.9 28857.6 28918.4 33636.7 34078.3 34647.8 34660.5 34813.8 29179.4 29333.0 29333.3 29725.3 30079.6 28767.7 28790.6 29473.4 29588.3 29923.0 30205.4 30943.0 30997.7 31080.7 31091.0 26561.0 26884.0 26986.2 27635.8 27760.2 22016.7 22028.0 22112.2 22221.9 22346.0 15:02:48 INFO - PID 28437 | 15:02:48 INFO - PID 28437 | [#2] jquery.html Cycles:180 Average:35878.07 Median:12614.22 stddev:100142.71 (793.9%) stddev-sans-first:100388.18 15:02:48 INFO - PID 28437 | Values: 389.2 406.3 414.2 429.3 429.4 14011.7 15749.0 19786.2 20030.4 21190.7 18842.3 19038.3 19565.1 19577.6 19886.1 6104.6 6325.7 6495.2 6553.1 6611.5 4133.7 4352.8 6437.0 6567.0 6579.1 6971.6 7298.3 7304.9 7322.4 7351.4 7467.4 7482.1 7790.3 7818.4 7820.3 7275.6 7380.3 7475.9 7620.2 7643.8 25872.2 26173.0 26445.2 27165.0 28357.9 2971.4 3037.2 3111.2 3122.9 3151.2 15822.1 16128.8 16936.6 16976.4 17777.9 2141.7 2219.7 2247.6 2263.0 2289.2 110609.4 112811.4 113541.4 113793.0 116040.0 19659.5 20509.5 20522.0 20856.0 21180.5 35034.8 35415.6 35586.0 35653.5 35776.0 9905.5 10286.8 10397.8 10495.9 10637.5 8109.1 8175.6 8221.3 8396.9 8488.4 9890.6 10080.1 10270.4 10292.4 10356.2 3493.6 3531.6 3594.6 3705.4 3770.8 878.8 893.4 918.0 925.5 930.9 21976.8 22939.2 23254.4 23298.4 23319.5 824.1 827.7 830.1 830.2 832.9 12033.2 12488.7 12544.6 12617.2 12745.4 572405.0 595363.0 605275.0 631954.0 632848.0 77710.0 78278.2 109372.0 110906.0 113522.5 1073.5 1077.7 1087.5 1094.3 1099.4 17211.7 17263.7 17866.8 17925.3 18182.7 48603.1 49154.3 50035.0 50246.0 50763.2 65214.3 65400.7 65955.7 65966.7 67746.7 8480.6 11505.9 13021.7 13342.5 13645.2 14014.9 14503.8 14732.6 15178.0 15216.8 12891.2 12948.9 13044.0 13220.3 13447.7 11872.9 12523.4 12571.6 12617.4 12868.9 12875.3 12911.5 13086.7 13110.2 13116.8 13184.4 13199.9 13208.5 13235.4 13273.6 12542.0 12627.6 12729.0 12773.5 12790.1 15:02:48 INFO - PID 28437 | 15:02:48 INFO - PID 28437 | [#3] mootools.html Cycles:180 Average:6295.15 Median:3795.40 stddev:4144.29 (109.2%) stddev-sans-first:4139.89 15:02:48 INFO - PID 28437 | Values: 1443.9 1481.2 1497.6 1516.3 1534.6 9879.3 10216.0 10230.7 10233.2 10236.9 10029.6 10177.1 10425.8 10458.3 10466.2 2024.4 2051.3 2067.7 2068.2 2073.0 1979.0 2004.8 2009.7 2022.6 2030.5 1978.7 1982.1 2007.5 2009.0 2012.4 1967.3 1975.1 1975.5 1976.3 1977.3 1958.0 1960.5 1993.7 2008.3 2009.2 10613.9 10683.6 10706.4 10708.5 10709.1 4947.0 5091.5 5098.3 5102.5 5102.8 2918.4 3117.2 3167.7 3175.8 3182.1 1196.3 1208.7 1213.9 1223.9 1317.3 13413.9 13790.2 14289.9 15582.0 15829.1 3878.7 3914.1 4033.1 4103.8 4108.0 11614.8 11718.1 11724.5 11762.1 11765.7 5071.3 5076.1 5077.5 5080.2 5088.1 4585.2 4628.9 4659.0 4681.0 4718.3 3299.5 3315.7 3363.1 3374.5 3404.9 895.1 896.8 903.8 915.7 917.8 805.4 815.2 816.3 819.7 824.2 5726.5 5857.0 5873.6 5949.2 6137.1 890.6 897.9 905.1 908.1 908.1 3667.8 3761.7 3829.1 3837.5 3856.5 12713.0 13264.9 13280.3 13347.9 13389.5 13187.7 13213.9 13325.2 13374.8 13382.2 9665.5 9695.3 9767.0 9809.0 9810.4 5700.7 5753.2 5777.1 5793.2 5856.0 11533.9 11647.7 11671.2 11802.7 11860.7 12133.9 12252.3 12263.2 12439.0 12449.6 8101.1 8151.8 8246.9 8250.7 8255.9 9432.5 9442.8 9494.6 9515.6 9579.6 8573.4 8586.1 8627.9 8630.5 8665.4 8178.5 8338.7 8383.0 8479.3 8564.6 7138.2 7158.1 7284.5 7293.7 7295.6 5256.4 5281.3 5334.6 5347.2 5401.6 5456.4 5459.8 5491.8 5632.0 5634.4 15:02:48 INFO - PID 28437 | 15:02:48 INFO - PID 28437 | [#4] prototype.html Cycles:180 Average:5205.71 Median:5753.71 stddev:1415.89 (24.6%) stddev-sans-first:1373.06 15:02:48 INFO - PID 28437 | Values: 395.7 403.1 406.8 411.4 412.5 5696.5 5756.1 5775.3 5780.9 5784.1 5540.4 5581.6 5663.5 5678.8 5710.9 4449.9 4486.3 4495.4 4502.9 4507.6 4473.8 4487.7 4496.0 4503.8 4504.5 4498.7 4501.5 4683.4 4716.2 4730.4 4623.6 4644.2 4693.8 4696.2 4698.4 4355.2 4361.8 4366.8 4389.2 4412.8 5365.0 5482.6 5482.9 5524.8 5547.3 5517.2 5527.6 5532.9 5549.6 5556.7 5797.5 6028.2 6054.7 6072.2 6074.9 4854.0 4857.9 4871.5 4872.6 4906.2 6017.0 6192.5 6246.8 6301.9 6326.4 4914.1 5035.7 5076.6 5082.9 5086.9 5152.5 5164.5 5164.8 5169.9 5172.0 5463.7 5482.9 5509.7 5521.6 5544.2 6002.8 6007.4 6008.3 6013.2 6017.3 1764.3 1770.5 1799.7 1799.9 1806.4 1327.5 1332.0 1354.0 1366.7 1371.5 5802.9 5803.1 5805.0 5809.9 5811.1 6140.6 6181.4 6191.7 6196.3 6234.6 5513.1 5668.7 5726.7 5727.0 5751.3 3277.2 3300.0 3301.0 3303.5 3314.2 6169.5 6359.6 6363.0 6407.6 6416.2 6310.5 6366.5 6379.7 6388.5 6396.1 6441.0 6451.5 6470.9 6474.6 6491.7 6063.5 6148.8 6170.2 6173.6 6183.9 5820.7 6117.1 6135.5 6138.5 6157.6 6214.0 6284.4 6435.3 6464.4 6471.8 5033.2 5072.4 5092.4 5093.1 5097.5 6071.8 6174.9 6187.4 6191.4 6271.2 6011.4 6018.7 6022.2 6034.8 6053.5 5857.4 6025.5 6052.8 6058.4 6063.0 5961.7 5997.6 6011.0 6028.3 6043.3 6011.4 6040.2 6054.2 6085.2 6090.6 5764.7 5891.4 5898.4 5908.8 5909.6 15:02:48 INFO - PID 28437 | 15:02:48 INFO - PID 28437 | [#5] yui.html Cycles:180 Average:17441.29 Median:23137.49 stddev:22749.17 (98.3%) stddev-sans-first:22778.11 15:02:48 INFO - PID 28437 | Values: 664.7 686.3 688.5 689.6 695.1 16481.4 16880.9 16889.7 16898.5 16916.7 14612.9 14841.7 14861.5 14869.9 14883.5 783.2 800.5 810.6 826.5 830.1 833.5 834.0 834.4 834.8 835.3 879.1 879.3 880.0 882.5 883.0 875.3 876.6 876.9 877.1 877.1 639.5 640.0 641.4 641.5 641.9 16911.2 17221.3 17336.9 17422.8 17430.1 12937.2 13378.7 13439.9 13440.0 13467.3 11972.2 12293.0 12354.5 12364.8 12381.4 3696.2 3701.4 3723.2 3792.8 3794.1 92363.6 94049.0 94117.5 94743.1 95970.5 10680.1 10906.9 10915.2 10961.9 11106.2 25040.9 25250.6 25437.2 25588.0 25944.7 8326.3 8332.9 8562.6 8597.7 8608.6 4290.2 4358.5 4402.0 4442.2 4460.9 3444.0 3520.2 3520.3 3523.9 3655.8 622.6 624.8 625.1 625.2 638.8 656.9 672.8 685.6 688.0 692.4 10119.7 10239.2 10304.7 10477.2 10549.9 570.7 591.6 596.1 630.9 695.8 4355.3 4841.8 4865.1 4966.1 4977.0 60690.0 68585.7 72223.3 79051.6 81553.8 65897.7 66422.3 66557.0 66913.3 68545.0 55264.4 59767.4 60223.0 60351.4 60743.7 9742.9 9956.0 9966.9 10079.2 10085.7 40080.4 41000.4 41279.6 41506.0 41984.8 48101.3 48139.3 48287.3 48950.3 50804.5 11017.6 11094.8 11169.7 11226.4 11460.2 12693.9 12903.5 13073.3 13200.3 13213.8 12541.7 12611.7 12625.0 12778.4 13274.9 11448.3 11572.8 11951.3 11965.2 12452.1 11683.2 11911.6 11940.3 12371.6 12398.8 10095.2 10764.2 11130.4 11225.2 11254.2 9834.9 10579.3 10614.1 10643.3 10688.5 15:02:48 INFO - PID 28437 | -------- Summary: end -------- 15:02:48 INFO - PID 28437 | 15:02:49 INFO - TEST-INFO | 28437: exit 0 15:02:49 INFO - TEST-OK | dromaeo_css | took 1115647ms 15:02:49 INFO - TEST-START | kraken 15:02:49 INFO - operating with platform_type : linux_ 15:02:49 INFO - Initialising browser for kraken test... 15:02:49 INFO - TEST-INFO | started process 28759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkx6Igg/profile http://localhost:44847/getInfo.html) 15:02:53 INFO - PID 28759 | __metrics Screen width/height:1600/1200 15:02:53 INFO - PID 28759 | colorDepth:24 15:02:53 INFO - PID 28759 | Browser inner width/height: 1024/697 15:02:53 INFO - PID 28759 | __metrics 15:02:54 INFO - PID 28759 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:02:54 INFO - PID 28759 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:02:54 INFO - TEST-INFO | 28759: exit 0 15:02:54 INFO - Browser initialized. 15:02:54 INFO - Running cycle 1/1 for kraken test... 15:02:54 INFO - TEST-INFO | started process 28852 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkx6Igg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:03:06 INFO - PID 28852 | RSS: Main: 144384000 15:03:06 INFO - PID 28852 | 15:03:09 INFO - PID 28852 | Cycle 1(1): loaded http://localhost:44847/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44847/tests/kraken/driver.html?testName=audio-beat-detection) 15:03:10 INFO - PID 28852 | RSS: Main: 198840320 15:03:10 INFO - PID 28852 | 15:03:12 INFO - PID 28852 | Cycle 1(1): loaded http://localhost:44847/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44847/tests/kraken/driver.html?testName=audio-dft) 15:03:13 INFO - PID 28852 | RSS: Main: 179044352 15:03:13 INFO - PID 28852 | 15:03:16 INFO - PID 28852 | Cycle 1(1): loaded http://localhost:44847/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44847/tests/kraken/driver.html?testName=audio-fft) 15:03:17 INFO - PID 28852 | RSS: Main: 261095424 15:03:17 INFO - PID 28852 | 15:03:19 INFO - PID 28852 | Cycle 1(1): loaded http://localhost:44847/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44847/tests/kraken/driver.html?testName=audio-oscillator) 15:03:19 INFO - PID 28852 | RSS: Main: 172875776 15:03:19 INFO - PID 28852 | 15:03:21 INFO - PID 28852 | Cycle 1(1): loaded http://localhost:44847/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44847/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:03:22 INFO - PID 28852 | RSS: Main: 176332800 15:03:22 INFO - PID 28852 | 15:03:25 INFO - PID 28852 | Cycle 1(1): loaded http://localhost:44847/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44847/tests/kraken/driver.html?testName=imaging-darkroom) 15:03:26 INFO - PID 28852 | RSS: Main: 214945792 15:03:26 INFO - PID 28852 | 15:03:29 INFO - PID 28852 | Cycle 1(1): loaded http://localhost:44847/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44847/tests/kraken/driver.html?testName=imaging-desaturate) 15:03:30 INFO - PID 28852 | RSS: Main: 232493056 15:03:30 INFO - PID 28852 | 15:03:32 INFO - PID 28852 | Cycle 1(1): loaded http://localhost:44847/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44847/tests/kraken/driver.html?testName=json-parse-financial) 15:03:33 INFO - PID 28852 | RSS: Main: 247832576 15:03:33 INFO - PID 28852 | 15:03:35 INFO - PID 28852 | Cycle 1(1): loaded http://localhost:44847/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44847/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:03:35 INFO - PID 28852 | RSS: Main: 177967104 15:03:35 INFO - PID 28852 | 15:03:37 INFO - PID 28852 | Cycle 1(1): loaded http://localhost:44847/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44847/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:03:38 INFO - PID 28852 | RSS: Main: 184176640 15:03:38 INFO - PID 28852 | 15:03:40 INFO - PID 28852 | Cycle 1(1): loaded http://localhost:44847/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44847/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:03:40 INFO - PID 28852 | RSS: Main: 193409024 15:03:40 INFO - PID 28852 | 15:03:43 INFO - PID 28852 | Cycle 1(1): loaded http://localhost:44847/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44847/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:03:43 INFO - PID 28852 | RSS: Main: 203046912 15:03:43 INFO - PID 28852 | 15:03:46 INFO - PID 28852 | Cycle 1(1): loaded http://localhost:44847/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44847/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:03:47 INFO - PID 28852 | RSS: Main: 199184384 15:03:47 INFO - PID 28852 | 15:03:49 INFO - PID 28852 | Cycle 1(1): loaded http://localhost:44847/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44847/tests/kraken/driver.html?testName=ai-astar) 15:03:49 INFO - PID 28852 | RSS: Main: 268537856 15:03:49 INFO - PID 28852 | 15:03:49 INFO - PID 28852 | __start_tp_report 15:03:49 INFO - PID 28852 | _x_x_mozilla_page_load 15:03:49 INFO - PID 28852 | _x_x_mozilla_page_load_details 15:03:49 INFO - PID 28852 | |i|pagename|runs| 15:03:49 INFO - PID 28852 | |0;ai-astar;105;114;114;116;114;115;116;116;115;115 15:03:49 INFO - PID 28852 | |1;audio-beat-detection;141;125;118;156;123;118;119;119;137;118 15:03:49 INFO - PID 28852 | |2;audio-dft;162;160;160;163;162;162;162;163;162;161 15:03:49 INFO - PID 28852 | |3;audio-fft;74;74;74;123;77;77;74;74;94;73 15:03:49 INFO - PID 28852 | |4;audio-oscillator;83;82;115;83;84;82;111;83;83;111 15:03:49 INFO - PID 28852 | |5;imaging-gaussian-blur;113;112;112;114;113;113;112;113;113;113 15:03:49 INFO - PID 28852 | |6;imaging-darkroom;147;147;146;146;147;147;147;147;147;146 15:03:49 INFO - PID 28852 | |7;imaging-desaturate;94;94;95;94;94;94;94;94;94;93 15:03:49 INFO - PID 28852 | |8;json-parse-financial;58;57;56;57;57;57;65;58;57;57 15:03:49 INFO - PID 28852 | |9;json-stringify-tinderbox;55;55;54;55;55;56;55;55;55;56 15:03:49 INFO - PID 28852 | |10;stanford-crypto-aes;82;81;78;85;78;86;79;79;78;78 15:03:49 INFO - PID 28852 | |11;stanford-crypto-ccm;126;133;128;124;123;125;124;124;168;126 15:03:49 INFO - PID 28852 | |12;stanford-crypto-pbkdf2;183;184;181;181;179;182;179;177;178;182 15:03:49 INFO - PID 28852 | |13;stanford-crypto-sha256-iterative;66;65;67;64;63;63;64;65;63;65 15:03:49 INFO - PID 28852 | __end_tp_report 15:03:49 INFO - PID 28852 | __start_cc_report 15:03:49 INFO - PID 28852 | _x_x_mozilla_cycle_collect,1768 15:03:49 INFO - PID 28852 | __end_cc_report 15:03:49 INFO - PID 28852 | __startTimestamp1489701829432__endTimestamp 15:03:49 INFO - PID 28852 | 15:03:49 INFO - PID 28852 | ------- Summary: start ------- 15:03:49 INFO - PID 28852 | Number of tests: 14 15:03:49 INFO - PID 28852 | 15:03:49 INFO - PID 28852 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.00 stddev:3.27 (2.8%) stddev-sans-first:0.87 15:03:49 INFO - PID 28852 | Values: 105.0 114.0 114.0 116.0 114.0 115.0 116.0 116.0 115.0 115.0 15:03:49 INFO - PID 28852 | 15:03:49 INFO - PID 28852 | [#1] audio-beat-detection Cycles:10 Average:127.40 Median:124.00 stddev:13.02 (10.5%) stddev-sans-first:12.85 15:03:49 INFO - PID 28852 | Values: 141.0 125.0 118.0 156.0 123.0 118.0 119.0 119.0 137.0 118.0 15:03:49 INFO - PID 28852 | 15:03:49 INFO - PID 28852 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 15:03:49 INFO - PID 28852 | Values: 162.0 160.0 160.0 163.0 162.0 162.0 162.0 163.0 162.0 161.0 15:03:49 INFO - PID 28852 | 15:03:49 INFO - PID 28852 | [#3] audio-fft Cycles:10 Average:81.40 Median:74.00 stddev:15.89 (21.5%) stddev-sans-first:16.63 15:03:49 INFO - PID 28852 | Values: 74.0 74.0 74.0 123.0 77.0 77.0 74.0 74.0 94.0 73.0 15:03:49 INFO - PID 28852 | 15:03:49 INFO - PID 28852 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:83.00 stddev:14.29 (17.2%) stddev-sans-first:14.81 15:03:49 INFO - PID 28852 | Values: 83.0 82.0 115.0 83.0 84.0 82.0 111.0 83.0 83.0 111.0 15:03:49 INFO - PID 28852 | 15:03:49 INFO - PID 28852 | [#5] imaging-gaussian-blur Cycles:10 Average:112.80 Median:113.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 15:03:49 INFO - PID 28852 | Values: 113.0 112.0 112.0 114.0 113.0 113.0 112.0 113.0 113.0 113.0 15:03:49 INFO - PID 28852 | 15:03:49 INFO - PID 28852 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 15:03:49 INFO - PID 28852 | Values: 147.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 147.0 146.0 15:03:49 INFO - PID 28852 | 15:03:49 INFO - PID 28852 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 15:03:49 INFO - PID 28852 | Values: 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 15:03:49 INFO - PID 28852 | 15:03:49 INFO - PID 28852 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:57.00 stddev:2.56 (4.5%) stddev-sans-first:2.71 15:03:49 INFO - PID 28852 | Values: 58.0 57.0 56.0 57.0 57.0 57.0 65.0 58.0 57.0 57.0 15:03:49 INFO - PID 28852 | 15:03:49 INFO - PID 28852 | [#9] json-stringify-tinderbox Cycles:10 Average:55.10 Median:55.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 15:03:49 INFO - PID 28852 | Values: 55.0 55.0 54.0 55.0 55.0 56.0 55.0 55.0 55.0 56.0 15:03:49 INFO - PID 28852 | 15:03:49 INFO - PID 28852 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.00 stddev:3.03 (3.8%) stddev-sans-first:3.15 15:03:49 INFO - PID 28852 | Values: 82.0 81.0 78.0 85.0 78.0 86.0 79.0 79.0 78.0 78.0 15:03:49 INFO - PID 28852 | 15:03:49 INFO - PID 28852 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:126.00 stddev:13.63 (10.8%) stddev-sans-first:14.37 15:03:49 INFO - PID 28852 | Values: 126.0 133.0 128.0 124.0 123.0 125.0 124.0 124.0 168.0 126.0 15:03:49 INFO - PID 28852 | 15:03:49 INFO - PID 28852 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.60 Median:181.50 stddev:2.27 (1.3%) stddev-sans-first:2.24 15:03:49 INFO - PID 28852 | Values: 183.0 184.0 181.0 181.0 179.0 182.0 179.0 177.0 178.0 182.0 15:03:49 INFO - PID 28852 | 15:03:49 INFO - PID 28852 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:1.35 (2.1%) stddev-sans-first:1.32 15:03:49 INFO - PID 28852 | Values: 66.0 65.0 67.0 64.0 63.0 63.0 64.0 65.0 63.0 65.0 15:03:49 INFO - PID 28852 | -------- Summary: end -------- 15:03:49 INFO - PID 28852 | 15:03:50 INFO - TEST-INFO | 28852: exit 0 15:03:50 INFO - TEST-OK | kraken | took 61281ms 15:03:50 INFO - SUITE-END | took 1176s 15:03:50 INFO - Completed test suite (00:19:37) 15:03:50 INFO - javascript benchmark 15:03:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7423.191145637145, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3131.4989601663733, 3207.871685132595, 3233.2401885556906, 3236.983815080925, 3258.918527036824, 5386.676799392039, 5482.80810171644, 5484.396716361197, 5521.0, 5555.277813884194, 5501.284832971718, 5527.2538207341995, 5532.2531458253125, 5534.557235421166, 5542.612017158801, 4961.652684312091, 4966.0, 4992.825251116212, 5000.0, 5047.26814611881, 5025.522575355335, 5097.464766199551, 5113.51421614946, 5140.33175687162, 5140.563052140554, 5083.085044691954, 5109.514596113363, 5109.846704598868, 5131.1277082895995, 5155.639105262633, 424.0526914945516, 4518.932216016762, 4990.850274491735, 4991.675541089818, 5088.567471764904, 4987.102321582114, 4989.57588604969, 5009.849704508834, 5027.069992051483, 5040.873978150539, 5550.333959924795, 5601.327840659106, 5605.299337582802, 5609.158626206061, 5614.719264036782, 5841.065429531254, 5915.5859089863725, 6064.332923378425, 6066.302375226861, 6072.332043475214, 5851.970740146315, 5937.435943585352, 5951.732172052268, 5978.3124940631515, 6002.54980876436, 5587.7485513152005, 5592.944070559283, 5601.523870471015, 5607.859803504904, 5611.494965453088, 6134.8159555213415, 6136.417040381246, 6138.14066030756, 6138.447539721446, 6143.877122457526, 5696.715164241771, 5710.457506536873, 5770.653760774367, 5786.566007549366, 5849.678267695318, 5967.194428752063, 5976.163337132805, 5983.042713165873, 5986.07215881539, 6039.275286965592, 5792.478676919013, 5880.588358814927, 5883.911741323884, 5920.4967577755515, 5928.851778705567, 5912.615679980788, 5929.080992446177, 5930.970345148246, 5952.5833191676165, 5991.5206783457215, 4484.282514797616, 4506.977465112719, 4525.615322697542, 4539.682222244412, 4548.931766023512, 4036.616521430459, 4064.4919385076864, 4070.063885306396, 4090.4886889138857, 4108.958910410917, 5590.18942253371, 5592.832215033555, 5594.300712410949, 5597.524210442158, 5600.6919619420505, 5824.446677565625, 5901.0558310670085, 6010.098485227163, 6010.278766548042, 6019.69901504923, 5565.693886836263, 5580.19087232349, 5620.409856965041, 5621.522170615462, 5625.521830644441, 5067.46791586878, 5071.315372424676, 5073.162928116893, 5074.543291103744, 5120.743962801845, 6075.483583895419, 6145.723442445012, 6154.107654390088, 6155.0, 6155.507559395238, 5944.613600115978, 5974.641521508724, 6048.304444988883, 6048.425399587032, 6059.0608455689435, 6131.448169664752, 6144.518437531025, 6152.876942461216, 6188.690565471798, 6192.102145189013, 5886.705664716833, 5894.852628684317, 5896.7936122235515, 5904.911426328523, 5914.112883067574, 5853.2390789198835, 5905.143754155538, 5975.940240597538, 6052.001419765689, 6060.39396060408, 5845.8538536535225, 5847.678377689268, 5849.0933905243055, 5850.678212698343, 5881.705914704162, 5686.374498805211, 5839.824805255679, 5845.853853653693, 5846.532277417711, 5852.707364631666, 5718.1708652246025, 5737.48362647347, 5768.163616275533, 5823.79616713413, 5838.036723940502, 5834.299884013945, 5871.588988770745, 5872.853178670567, 5880.470757631662, 5896.823095307148, 5640.294963129609, 5643.548516118619, 5693.772249109989, 5695.174199741097, 5699.971500142473], "value": 5444.326231979565, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.2786400591277, 639.8624295776407, 656.0421784195073, 766.961651917404, 775.7440044785221, 29749.702502974964, 36415.453768193496, 37476.06309842252, 37689.434658480146, 37868.24263514728, 39362.8031859841, 39823.20353592934, 39888.60111398885, 43582.78208608952, 43722.781386093106, 7131.928680713178, 8911.777205569864, 9144.085591440837, 9144.634214631407, 9149.542522873862, 7290.890636640454, 10080.0, 10297.691069267934, 10298.227632927523, 10305.690829275096, 10410.553519922812, 10457.163426925828, 10493.317934334282, 10504.579816807318, 10519.947400262989, 10706.304090234109, 10710.839337409945, 10778.083862871705, 10804.243702940797, 10820.78358432827, 10168.237382196365, 10227.18182545402, 10238.436885971269, 10254.282200245985, 10258.435786031765, 41348.58651413507, 41653.375199372036, 41723.79138104321, 41755.58244417578, 41783.79108104471, 3501.2822371414054, 3509.157802127471, 3555.182308069133, 3578.1054736315923, 3584.17563960288, 28455.288617784514, 28897.855510722522, 28955.0, 28973.42053158946, 28996.420071598663, 4155.127423241123, 4208.768517731523, 4220.345846393814, 4438.644908407319, 4440.200763862504, 219801.0, 221242.0, 221366.0, 221552.0, 221660.0, 42813.571864281585, 43022.784886075366, 43201.351979720326, 43613.0, 43618.7819060909, 52947.205791913155, 52967.735161324716, 53062.0, 53079.734601326745, 53123.46876531185, 15351.923240383727, 15479.380824766884, 15492.612684682748, 15494.14782186968, 15501.612459688373, 10659.307145035547, 10891.292066015683, 12553.686157846127, 12644.30456324911, 12661.430235639418, 11471.0, 11542.480588373543, 11634.6509604712, 11715.76568468626, 11718.824217636742, 4740.525947405232, 4802.255650374198, 4817.78319975602, 4849.709017458964, 4902.828401005948, 781.2656103262915, 802.2058162419163, 814.5031530766228, 820.8481430935177, 840.6175190288526, 23039.0, 23753.52492950166, 23972.160974365812, 24083.51832963331, 24087.75912240855, 850.8340873529602, 866.3805379153936, 868.7914900423852, 871.9738407847775, 893.0578239956778, 12198.817017744741, 12575.0, 12716.745665086646, 12726.618201453972, 12855.742885142432, 243601.0, 245370.0, 295111.0, 296809.0, 297172.0, 48601.75699121482, 49340.753296234005, 49624.0, 49644.50355496471, 49710.25434618411, 1168.2990205876406, 1210.922279171538, 1211.6183402228446, 1211.9697007574882, 1223.804191329383, 26380.340491487867, 27611.44777104487, 28677.713222867504, 30669.693303067575, 30860.382792344477, 49204.753976231324, 49548.25677614767, 49708.502914970384, 49735.75132124316, 49936.75031624819, 254804.0, 256754.0, 257169.0, 257316.0, 257605.0, 28481.572776407957, 28628.42743145167, 28790.856045719636, 28857.567136493388, 28918.42163156767, 33636.66363336335, 34078.318433631684, 34647.84225892909, 34660.48009279913, 34813.82593087018, 29179.41641167207, 29333.0, 29333.26666833346, 29725.256868577595, 30079.6464159109, 28767.71232287734, 28790.568141477477, 29473.410531789672, 29588.260293492836, 29923.0, 30205.395892082473, 30943.0, 30997.69002309948, 31080.68919310778, 31091.0, 26561.0, 26884.0, 26986.1904142876, 27635.833037673186, 27760.167194984184, 22016.669749953442, 22028.0, 22112.2260720874, 22221.888890555445, 22346.0], "value": 16984.253496340178, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.213788147941, 406.3275279412573, 414.169589972106, 429.25738472442674, 429.3859780513866, 14011.719765604681, 15749.0, 19786.208551657917, 20030.399088027345, 21190.682139767916, 18842.34051808187, 19038.33365832196, 19565.119569619364, 19577.60844783107, 19886.10512526936, 6104.633721976674, 6325.746970121189, 6495.155629768147, 6553.115329430538, 6611.504137189706, 4133.73130746502, 4352.825886964518, 6436.967815160941, 6566.967165164191, 6579.078928949927, 6971.58170509771, 7298.270172982686, 7304.890426643605, 7322.414206863465, 7351.411887049023, 7467.439942004345, 7482.102147742278, 7790.298873101448, 7818.413618978542, 7820.296173344369, 7275.563466191992, 7380.335769780745, 7475.9252407476315, 7620.161782203953, 7643.847123057563, 25872.223833284843, 26173.0, 26445.206643800717, 27165.0, 28357.858210708815, 2971.435427268834, 3037.1951432870305, 3111.2377467520378, 3122.9063128106195, 3151.2121969507625, 15822.129782861937, 16128.83871161285, 16936.576585585335, 16976.405825796162, 17777.911110444493, 2141.7215761951, 2219.6670499425054, 2247.6179049561615, 2263.0155882191298, 2289.2331069091874, 110609.44695276472, 112811.43594282058, 113541.43229283801, 113793.0, 116040.0, 19659.508512287022, 20509.48726281825, 20522.022512345575, 20856.0, 21180.470488237916, 35034.82482587571, 35415.64584354175, 35586.0, 35653.46519802205, 35776.0, 9905.455199964072, 10286.845697314397, 10397.84403233952, 10495.895041049644, 10637.521311540999, 8109.107998120202, 8175.591220438954, 8221.301189398848, 8396.916030839735, 8488.363372747068, 9890.554925028391, 10080.14318782897, 10270.383776973256, 10292.382457052601, 10356.223283253636, 3493.589263701086, 3531.5585551806025, 3594.6045934947133, 3705.40713485841, 3770.773753574739, 878.8242351529719, 893.3612467085935, 917.9541022948825, 925.500229875873, 930.9441433514011, 21976.780232197794, 22939.19712810077, 23254.418639533807, 23298.417539561648, 23319.53360932772, 824.1305422778906, 827.6896163938524, 830.1197787012421, 830.1698301698302, 832.9416940814085, 12033.157678962563, 12488.740027770531, 12544.556624250796, 12617.242965422103, 12745.36273186337, 572405.0, 595363.0, 605275.0, 631954.0, 632848.0, 77710.0, 78278.21721782823, 109372.0, 110906.0, 113522.459101635, 1073.468633026641, 1077.73595469109, 1087.4508373271447, 1094.2777766673958, 1099.3623698254994, 17211.741823872904, 17263.654726905643, 17866.76665416823, 17925.28298868031, 18182.72725909139, 48603.11175105912, 49154.262686059024, 50035.0, 50246.0, 50763.238551422495, 65214.34785652273, 65400.67299663471, 65955.67022164859, 65966.67016664887, 67746.66126669335, 8480.61837217339, 11505.942470287595, 13021.674458138243, 13342.533011344556, 13645.249511276976, 14014.929925350309, 14503.78244326357, 14732.631684207981, 15178.0, 15216.847831521543, 12891.226526408445, 12948.935255323662, 13044.0, 13220.338983051, 13447.663808404868, 11872.872077152657, 12523.436445360163, 12571.622851314476, 12617.36913154357, 12868.871311286768, 12875.291858947849, 12911.5480958166, 13086.672833179247, 13110.213387196798, 13116.803247951097, 13184.40670169864, 13199.868001320248, 13208.471661133448, 13235.40440680191, 13273.601791946257, 12542.0, 12627.621171364874, 12729.0, 12773.48906043785, 12790.104692671795], "value": 11333.53709415182, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1443.9205843678606, 1481.1853480585676, 1497.625593601599, 1516.317657054325, 1534.608674787929, 9879.308448408614, 10216.0, 10230.670012898332, 10233.232507561925, 10236.948815255922, 10029.648962286321, 10177.08406243438, 10425.843612345821, 10458.320209186397, 10466.162706983441, 2024.3623258673508, 2051.2923041550716, 2067.7208576842086, 2068.1727309076414, 2073.0, 1979.0, 2004.7794742578305, 2009.6985452182143, 2022.6460369435363, 2030.4619275891826, 1978.6636271833822, 1982.1476764991048, 2007.5382661987678, 2009.0, 2012.376163389354, 1967.2721093195537, 1975.051975051976, 1975.4666240115089, 1976.3379267945184, 1977.3178253502663, 1957.9706304405445, 1960.5098725318671, 1993.6810110382414, 2008.347287131688, 2009.156154415149, 10613.946930265376, 10683.572657093708, 10706.41114738689, 10708.46457677113, 10709.143268538499, 4946.950530494685, 5091.46539613339, 5098.337216161913, 5102.540771330598, 5102.821401250975, 2918.357961248522, 3117.2051126962706, 3167.7307428868576, 3175.8249447704497, 3182.0931034655246, 1196.2583198417037, 1208.7159517513378, 1213.915025948184, 1223.892377398456, 1317.295247042837, 13413.932930335384, 13790.172589644653, 14289.857101429061, 15582.0, 15829.129397883113, 3878.7090968176935, 3914.0606254498716, 4033.052232725307, 4103.7742924138865, 4107.97946010274, 11614.825777613343, 11718.06255499558, 11724.531018759155, 11762.059035277158, 11765.705857353634, 5071.264666623319, 5076.0863044652315, 5077.517635824591, 5080.212567052039, 5088.084144853888, 4585.151746926829, 4628.884277893079, 4658.976705116521, 4681.0, 4718.292256161603, 3299.5215693724276, 3315.668433156665, 3363.081632247417, 3374.54443650109, 3404.914877128042, 895.0914821456228, 896.789254525186, 903.7966457547, 915.6840889893109, 917.8347897378536, 805.4040010392267, 815.2133191470259, 816.3061397811813, 819.663937785505, 824.1634740738156, 5726.539732368219, 5856.970715146397, 5873.647581145145, 5949.2266005419015, 6137.079438084323, 890.5858775669345, 897.9146981036791, 905.1446383167843, 908.0919080919081, 908.096444038173, 3667.7982710951155, 3761.652129604654, 3829.1384438501673, 3837.4819399381286, 3856.537215534154, 12713.0, 13264.867351326557, 13280.335983200801, 13347.933260333637, 13389.464421423228, 13187.73624527504, 13213.88577827543, 13325.200487970753, 13374.799378009338, 13382.197068175941, 9665.516724163623, 9695.272854535939, 9766.951165244129, 9808.950955245178, 9810.362326448902, 5700.686462244616, 5753.165790960371, 5777.104548794943, 5793.1903027032695, 5856.0, 11533.88466115328, 11647.708807279547, 11671.183017188716, 11802.704932376415, 11860.703482413008, 12133.939330303292, 12252.264864108181, 12263.202891812003, 12439.0, 12449.564265250672, 8101.149379315087, 8151.79620509492, 8246.917530824854, 8250.669973201006, 8255.876161857697, 9432.52837358143, 9442.811143777224, 9494.620215191591, 9515.619375225191, 9579.568919398504, 8573.356998225034, 8586.141385861614, 8627.87058194115, 8630.5253211074, 8665.350098742745, 8178.46839955401, 8338.749837504885, 8382.958085209535, 8479.32165426752, 8564.614592343234, 7138.214796372498, 7158.105236845395, 7284.49008569395, 7293.744718934812, 7295.598742069237, 5256.448072952285, 5281.287026251407, 5334.573234141337, 5347.1979203119845, 5401.648892821954, 5456.427075157051, 5459.818635095015, 5491.780328786964, 5632.043177331933, 5634.408387119293], "value": 4690.789759183752, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.69729157194735, 403.1372862075158, 406.84539874847553, 411.37471044013097, 412.4576182320248, 5696.544276457884, 5756.136579513065, 5775.3358363788175, 5780.884382312352, 5784.13238014297, 5540.3628582713, 5581.553475721943, 5663.461971112738, 5678.772849086042, 5710.942890571093, 4449.88875278119, 4486.3046227834575, 4495.393121928547, 4502.864914052584, 4507.6168525675275, 4473.82104715811, 4487.708298960573, 4496.010877606921, 4503.819847206108, 4504.504504504502, 4498.707584007046, 4501.459824821026, 4683.437987441512, 4716.2218233991525, 4730.385049943503, 4623.56076172763, 4644.187267228222, 4693.812247510095, 4696.248600223965, 4698.4361876574685, 4355.237833379146, 4361.803718832628, 4366.8034938427845, 4389.2318844202455, 4412.75729834859, 5365.0, 5482.588805839578, 5482.945170548323, 5524.806631767869, 5547.308071038332, 5517.200005999108, 5527.613067085305, 5532.917006244909, 5549.6115271930985, 5556.749946252428, 5797.507211886995, 6028.246469191351, 6054.697265136726, 6072.180255665517, 6074.908876366858, 4853.975730121362, 4857.902841943177, 4871.464138944713, 4872.561469467765, 4906.165951788204, 6017.0, 6192.504599632064, 6246.781362652286, 6301.905471417932, 6326.4377926939205, 4914.140025495524, 5035.723035233097, 5076.619253555924, 5082.872928176751, 5086.949130508648, 5152.5362717354865, 5164.509371609691, 5164.845054648366, 5169.896602067937, 5172.0, 5463.6554362581755, 5482.945170548243, 5509.696966666792, 5521.641093328921, 5544.22380866679, 6002.789902353396, 6007.369226231182, 6008.279006519246, 6013.218281623361, 6017.277926648742, 1764.303100275384, 1770.5485101299344, 1799.6580649676519, 1799.8920064796155, 1806.4219449776208, 1327.4889167670324, 1332.0478514087886, 1354.0048064672458, 1366.6719987203, 1371.5268232459784, 5802.854928626733, 5803.100519419497, 5805.0, 5809.883802324014, 5811.0992796115825, 6140.631562106288, 6181.412765787243, 6191.690415479208, 6196.318404975449, 6234.625922444668, 5513.145462453326, 5668.659880407106, 5726.685032323262, 5726.9713651431475, 5751.281089863767, 3277.1807048237943, 3299.9835000825324, 3300.9834950825093, 3303.487959366302, 3314.171457135716, 6169.475594574512, 6359.632678974042, 6362.968185159045, 6407.647579383085, 6416.165898433267, 6310.495160387158, 6366.522510811707, 6379.744810207632, 6388.520860935449, 6396.0725694774, 6441.0, 6451.516136289797, 6470.870582588322, 6474.579152355176, 6491.675416229265, 6063.454289114001, 6148.846278843064, 6170.228721409824, 6173.59871608344, 6183.938160618336, 5820.679862607428, 6117.113018612187, 6135.478484328703, 6138.508919286535, 6157.630542167484, 6214.0, 6284.4344009039405, 6435.2599451063725, 6464.353564643498, 6471.805845824632, 5033.245013248042, 5072.416672082758, 5092.351976972028, 5093.1341671915125, 5097.464766199496, 6071.7571297147615, 6174.907376389448, 6187.381261873957, 6191.442770150708, 6271.153394291712, 6011.398860113954, 6018.7291571878495, 6022.1870047543025, 6034.758609655741, 6053.4551890330085, 5857.384974577779, 6025.457708806229, 6052.788152414644, 6058.394160583906, 6063.0, 5961.672108034099, 5997.580169388101, 6011.0, 6028.2766068072115, 6043.2748070231855, 6011.428914253139, 6040.161124271585, 6054.182685337423, 6085.2393450818645, 6090.634561926298, 5764.682942438206, 5891.351951285269, 5898.4101589840675, 5908.793192238423, 5909.55678324136], "value": 4782.705642041719, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.7440735316901, 686.2691233835963, 688.5249178067135, 689.6482793775176, 695.0859619600222, 16481.423150189745, 16880.915595422022, 16889.746653800205, 16898.493045208663, 16916.74624880625, 14612.853871461282, 14841.703165936675, 14861.479848205288, 14869.925650371733, 14883.479078232263, 783.2089589514575, 800.5156880087551, 810.5703976892227, 826.5288785392329, 830.0744669693279, 833.4582521361103, 833.9874901876477, 834.3575446905879, 834.7704381295132, 835.2858306148247, 879.1428357351595, 879.3141349747208, 880.0143838900441, 882.483747008001, 882.9646814127459, 875.2735229759285, 876.609908590671, 876.8991565969867, 877.0878286581947, 877.1141147441067, 639.5107742576886, 640.0239634557291, 641.425923798198, 641.5252712992352, 641.8940874755659, 16911.154442277835, 17221.311147554083, 17336.913315433467, 17422.825771742246, 17430.12849357527, 12937.15908465956, 13378.732425351536, 13439.86560134396, 13440.0, 13467.326633668376, 11972.161948663597, 12292.955098816612, 12354.505819767199, 12364.752704945851, 12381.380930953506, 3696.2237930034726, 3701.38927077032, 3723.2181241938956, 3792.829322680486, 3794.0894185395305, 92363.56028453603, 94049.0, 94117.5294123525, 94743.05256947411, 95970.52014739881, 10680.092192163598, 10906.945465272782, 10915.181361397927, 10961.890381096087, 11106.222564420576, 25040.874795625907, 25250.621240681405, 25437.236882893543, 25588.010337983913, 25944.74055259461, 8326.25063744266, 8332.916670833336, 8562.61468233931, 8597.656093756304, 8608.612612432456, 4290.184864875664, 4358.4769827620885, 4401.955980440154, 4442.20040392726, 4460.8661740147845, 3443.9827800860835, 3520.1727594015388, 3520.2783429396914, 3523.9295214095573, 3655.7623754455876, 622.6326467384265, 624.8063100438878, 625.0993798696194, 625.1622825413967, 638.8307098618869, 656.8916128838688, 672.8183390484542, 685.6263336481529, 687.9862402751917, 692.3526502719973, 10119.66221237924, 10239.232057595711, 10304.690859274233, 10477.161827053817, 10549.9472502637, 570.7460180219846, 591.5740666719955, 596.1058412381428, 630.8517498387876, 695.7564852301654, 4355.259605867011, 4841.782119804618, 4865.125480274582, 4966.106100901872, 4976.975115124474, 60690.0, 68585.65707171432, 72223.27776722271, 79051.60474197593, 81553.84461553796, 65897.67051164714, 66422.33577664258, 66557.0, 66913.33086669169, 68545.0, 55264.44735552673, 59767.402325977055, 60223.0, 60351.39648603545, 60743.69628151831, 9742.853857192005, 9956.0, 9966.900330996597, 10079.24405669563, 10085.69742907714, 40080.39879401753, 41000.384994224514, 41279.58720412757, 41506.0, 41984.790076050645, 48101.316453923944, 48139.277910830664, 48287.309944151784, 48950.26574601312, 50804.491955079975, 11017.61438349686, 11094.79425779952, 11169.664910052712, 11226.438678066228, 11460.197786155222, 12693.873061269638, 12903.483860645469, 13073.346332683517, 13200.273984930922, 13213.801792973305, 12541.686457838627, 12611.68470788201, 12624.990000800097, 12778.361081945679, 13274.933625332198, 11448.313101213955, 11572.768544629229, 11951.282923024299, 11965.162438629213, 12452.066095043088, 11683.18217724751, 11911.642650720492, 11940.283582985048, 12371.566995155126, 12398.81401778956, 10095.236191751397, 10764.246502745045, 11130.387828669178, 11225.214235003472, 11254.155938304497, 9834.901650983398, 10579.312344697877, 10614.097801686634, 10643.254972151875, 10688.519016644113], "value": 7115.92113454136, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1498.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 114.0, 116.0, 114.0, 115.0, 116.0, 116.0, 115.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 125.0, 118.0, 156.0, 123.0, 118.0, 119.0, 119.0, 137.0, 118.0], "value": 127.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 163.0, 162.0, 162.0, 162.0, 163.0, 162.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 123.0, 77.0, 77.0, 74.0, 74.0, 94.0, 73.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 115.0, 83.0, 84.0, 82.0, 111.0, 83.0, 83.0, 111.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 112.0, 114.0, 113.0, 113.0, 112.0, 113.0, 113.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 56.0, 57.0, 57.0, 57.0, 65.0, 58.0, 57.0, 57.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 55.0, 55.0, 56.0, 55.0, 55.0, 55.0, 56.0], "value": 55.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 78.0, 85.0, 78.0, 86.0, 79.0, 79.0, 78.0, 78.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 133.0, 128.0, 124.0, 123.0, 125.0, 124.0, 124.0, 168.0, 126.0], "value": 130.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 181.0, 181.0, 179.0, 182.0, 179.0, 177.0, 178.0, 182.0], "value": 180.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 64.0, 63.0, 63.0, 64.0, 65.0, 63.0, 65.0], "value": 64.5, "unit": "score"}]}]} 15:03:50 INFO - Return code: 0 15:03:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:03:50 ERROR - # TBPL SUCCESS # 15:03:50 INFO - Running post-action listener: _resource_record_post_action 15:03:50 INFO - [mozharness: 2017-03-16 22:03:50.737691Z] Finished run-tests step (success) 15:03:50 INFO - Running post-run listener: _resource_record_post_run 15:03:50 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 379555840; Read time: 16; Write time: 276436 15:03:50 INFO - TinderboxPrint: CPU usage
12.9% 15:03:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 15:03:50 INFO - TinderboxPrint: I/O write bytes / time
379,555,840 / 276,436 15:03:50 INFO - TinderboxPrint: CPU idle
8,297.7 (87.1%) 15:03:50 INFO - TinderboxPrint: CPU user
1,187.1 (12.5%) 15:03:50 INFO - TinderboxPrint: Swap in / out
0 / 0 15:03:50 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 123478016; Read time: 0; Write time: 102380 15:03:50 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 256077824; Read time: 16; Write time: 174056 15:03:51 INFO - Running post-run listener: _upload_blobber_files 15:03:51 INFO - Blob upload gear active. 15:03:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:03:51 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 15:03:51 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'] 15:03:51 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 15:03:51 INFO - (blobuploader) - INFO - Open directory for files ... 15:03:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:03:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:03:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:03:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:03:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:03:52 INFO - (blobuploader) - INFO - Done attempting. 15:03:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:03:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:03:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:03:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:03:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:03:53 INFO - (blobuploader) - INFO - Done attempting. 15:03:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:03:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:03:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:03:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:03:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:03:54 INFO - (blobuploader) - INFO - Done attempting. 15:03:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:03:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:03:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:03:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:03:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:03:57 INFO - (blobuploader) - INFO - Done attempting. 15:03:57 INFO - (blobuploader) - INFO - Iteration through files over. 15:03:57 INFO - Return code: 0 15:03:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:03:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:03:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1b2ef41a829f3f1d644ba1ad23c07f6f7d0afb00c3a54b98ae51138064464a5ad68c2ec3ce2bf88d77e9c9c934931e1c50afa6b0675e2c1a83d32dba4ddbea8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80f4c788a298bf9676e5df16a09f2f841edd561370d9c85031df3dbf97c3cc74a4302acec7d5c619c43dad86796ccdcc66330638ba975a53c6d05bdf60a18325", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38c1cb8702d6d112341e57389ac056588734c174a3a28ba1c25a98b8d65313674ed5a44fa620f1b3ddd2858a470ff7aa22d21c7b0ff8975562949d828f29b9d5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88f4cc0d2850be62c5fee81defcf501ae203cb826db7ccfb9b35ae6c6b6524ba6ba1ef356f993b8c48958166b8e8603396da1289e233606fd6fac68abad42a88"} 15:03:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:03:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:03:57 INFO - Contents: 15:03:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1b2ef41a829f3f1d644ba1ad23c07f6f7d0afb00c3a54b98ae51138064464a5ad68c2ec3ce2bf88d77e9c9c934931e1c50afa6b0675e2c1a83d32dba4ddbea8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80f4c788a298bf9676e5df16a09f2f841edd561370d9c85031df3dbf97c3cc74a4302acec7d5c619c43dad86796ccdcc66330638ba975a53c6d05bdf60a18325", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38c1cb8702d6d112341e57389ac056588734c174a3a28ba1c25a98b8d65313674ed5a44fa620f1b3ddd2858a470ff7aa22d21c7b0ff8975562949d828f29b9d5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88f4cc0d2850be62c5fee81defcf501ae203cb826db7ccfb9b35ae6c6b6524ba6ba1ef356f993b8c48958166b8e8603396da1289e233606fd6fac68abad42a88"} 15:03:57 INFO - Running post-run listener: copy_logs_to_upload_dir 15:03:57 INFO - Copying logs to upload dir... 15:03:57 INFO - mkdir: /builds/slave/test/build/upload/logs 15:03:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.043963 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-16 15:03:56.879775) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-16 15:03:56.882963) ========= 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=2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1b2ef41a829f3f1d644ba1ad23c07f6f7d0afb00c3a54b98ae51138064464a5ad68c2ec3ce2bf88d77e9c9c934931e1c50afa6b0675e2c1a83d32dba4ddbea8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80f4c788a298bf9676e5df16a09f2f841edd561370d9c85031df3dbf97c3cc74a4302acec7d5c619c43dad86796ccdcc66330638ba975a53c6d05bdf60a18325", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38c1cb8702d6d112341e57389ac056588734c174a3a28ba1c25a98b8d65313674ed5a44fa620f1b3ddd2858a470ff7aa22d21c7b0ff8975562949d828f29b9d5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88f4cc0d2850be62c5fee81defcf501ae203cb826db7ccfb9b35ae6c6b6524ba6ba1ef356f993b8c48958166b8e8603396da1289e233606fd6fac68abad42a88"} build_url:https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011308 build_url: 'https://queue.taskcluster.net/v1/task/fwOngqxxRniV0qauGCx8Ew/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1b2ef41a829f3f1d644ba1ad23c07f6f7d0afb00c3a54b98ae51138064464a5ad68c2ec3ce2bf88d77e9c9c934931e1c50afa6b0675e2c1a83d32dba4ddbea8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80f4c788a298bf9676e5df16a09f2f841edd561370d9c85031df3dbf97c3cc74a4302acec7d5c619c43dad86796ccdcc66330638ba975a53c6d05bdf60a18325", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38c1cb8702d6d112341e57389ac056588734c174a3a28ba1c25a98b8d65313674ed5a44fa620f1b3ddd2858a470ff7aa22d21c7b0ff8975562949d828f29b9d5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88f4cc0d2850be62c5fee81defcf501ae203cb826db7ccfb9b35ae6c6b6524ba6ba1ef356f993b8c48958166b8e8603396da1289e233606fd6fac68abad42a88"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-16 15:03:56.907910) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 15:03:56.908271) ========= 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=2432103b8b3de4003b23cad4000001c2-1489700581.579593-58247882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 15:03:56.993712) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-16 15:03:56.994088) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-16 15:03:56.994439) ========= ========= Total master_lag: 0.17 =========