builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-074 starttime: 1494214558.26 results: success (0) revision: 22aaf8bad4df8e5f8c976f1521c213cb37e2dff5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-07 20:35:58.261464) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-07 20:35:58.261835) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-07 20:35:58.262098) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-07 20:35:58.319691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 20:35:58.319976) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-07 20:35:58-- 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% 226M=0s 2017-05-07 20:35:58 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.182655 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 20:35:58.547017) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 20:35:58.547320) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018471 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 20:35:58.596492) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 20:35:58.598825) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 22aaf8bad4df8e5f8c976f1521c213cb37e2dff5 --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 22aaf8bad4df8e5f8c976f1521c213cb37e2dff5 --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=23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-07 20:35:58,345 truncating revision to first 12 chars 2017-05-07 20:35:58,345 Setting DEBUG logging. 2017-05-07 20:35:58,346 attempt 1/10 2017-05-07 20:35:58,346 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/22aaf8bad4df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-07 20:35:58,775 unpacking tar archive at: mozilla-central-22aaf8bad4df/testing/mozharness/ program finished with exit code 0 elapsedTime=0.715016 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 20:35:59.331590) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-07 20:35:59.331887) ========= script_repo_revision: 22aaf8bad4df8e5f8c976f1521c213cb37e2dff5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-07 20:35:59.332234) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-07 20:35:59.332500) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-07 20:35:59.354052) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-05-07 20:35:59.354317) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:35:59 INFO - MultiFileLogger online at 20170507 20:35:59 in /builds/slave/test 20:35:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 20:35:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:35:59 INFO - {'append_to_log': False, 20:35:59 INFO - 'base_work_dir': '/builds/slave/test', 20:35:59 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 20:35:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:35:59 INFO - 'branch': 'Firefox-Non-PGO', 20:35:59 INFO - 'buildbot_json_path': 'buildprops.json', 20:35:59 INFO - 'config_files': ('talos/linux_config.py',), 20:35:59 INFO - 'default_actions': ('clobber', 20:35:59 INFO - 'read-buildbot-config', 20:35:59 INFO - 'download-and-extract', 20:35:59 INFO - 'populate-webroot', 20:35:59 INFO - 'create-virtualenv', 20:35:59 INFO - 'install', 20:35:59 INFO - 'run-tests'), 20:35:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:35:59 INFO - 'download_minidump_stackwalk': True, 20:35:59 INFO - 'download_symbols': 'ondemand', 20:35:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:35:59 INFO - 'tooltool.py': '/tools/tooltool.py', 20:35:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:35:59 INFO - '/tools/misc-python/virtualenv.py')}, 20:35:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:35:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:35:59 INFO - 'gecko_profile': False, 20:35:59 INFO - 'gecko_profile_interval': 0, 20:35:59 INFO - 'installer_path': 'installer.exe', 20:35:59 INFO - 'log_level': 'info', 20:35:59 INFO - 'log_name': 'talos', 20:35:59 INFO - 'log_to_console': True, 20:35:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:35:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:35:59 INFO - 'opt_config_files': (), 20:35:59 INFO - 'pip_index': False, 20:35:59 INFO - 'suite': 'dromaeojs-e10s', 20:35:59 INFO - 'system_bits': '32', 20:35:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:35:59 INFO - 'title': 'talos-linux64-ix-074', 20:35:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:35:59 INFO - 'use_talos_json': True, 20:35:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:35:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:35:59 INFO - 'work_dir': 'build'} 20:35:59 INFO - [mozharness: 2017-05-08 03:35:59.317855Z] Running clobber step. 20:35:59 INFO - Running pre-action listener: _resource_record_pre_action 20:35:59 INFO - Running main action method: clobber 20:35:59 INFO - rmtree: /builds/slave/test/build 20:35:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:36:00 INFO - Running post-action listener: _resource_record_post_action 20:36:00 INFO - [mozharness: 2017-05-08 03:36:00.212043Z] Finished clobber step (success) 20:36:00 INFO - [mozharness: 2017-05-08 03:36:00.212143Z] Running read-buildbot-config step. 20:36:00 INFO - Running pre-action listener: _resource_record_pre_action 20:36:00 INFO - Running main action method: read_buildbot_config 20:36:00 INFO - Using buildbot properties: 20:36:00 INFO - { 20:36:00 INFO - "project": "", 20:36:00 INFO - "product": "firefox", 20:36:00 INFO - "who": "ihsiao@mozilla.com", 20:36:00 INFO - "installer_path": "public/build/target.tar.bz2", 20:36:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 20:36:00 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 20:36:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 20:36:00 INFO - "stage_platform": "linux64", 20:36:00 INFO - "basedir": "/builds/slave/test", 20:36:00 INFO - "buildnumber": 585, 20:36:00 INFO - "platform": "ubuntu64_hw", 20:36:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:36:00 INFO - "slavebuilddir": "test", 20:36:00 INFO - "taskId": "Bl28jr3bRvWcQp-CR4hssg", 20:36:00 INFO - "branch": "mozilla-central", 20:36:00 INFO - "script_repo_revision": "production", 20:36:00 INFO - "revision": "22aaf8bad4df8e5f8c976f1521c213cb37e2dff5", 20:36:00 INFO - "slavename": "talos-linux64-ix-074", 20:36:00 INFO - "repo_path": "mozilla-central" 20:36:00 INFO - } 20:36:00 INFO - Finding installer, test and symbols from parent task. 20:36:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bl28jr3bRvWcQp-CR4hssg'}, attempt #1 20:36:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bl28jr3bRvWcQp-CR4hssg'}, attempt #1 20:36:01 INFO - Task dependencies: L3lETsAqR0et1hVv4ApFkA 20:36:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA'}, attempt #1 20:36:01 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.tar.bz2 20:36:01 INFO - Set test_url: https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/test_packages.json 20:36:01 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.crashreporter-symbols.zip 20:36:01 INFO - Running post-action listener: _resource_record_post_action 20:36:01 INFO - [mozharness: 2017-05-08 03:36:01.669240Z] Finished read-buildbot-config step (success) 20:36:01 INFO - [mozharness: 2017-05-08 03:36:01.669496Z] Running download-and-extract step. 20:36:01 INFO - Running pre-action listener: _resource_record_pre_action 20:36:01 INFO - Running main action method: download_and_extract 20:36:01 INFO - mkdir: /builds/slave/test/build/tests 20:36:01 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')]} 20:36:01 INFO - trying https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.test_packages.json 20:36:01 INFO - Downloading https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 20:36:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 20:36:02 INFO - Downloaded 986 bytes. 20:36:02 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 20:36:02 INFO - Using the following test package requirements: 20:36:02 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 20:36:02 INFO - u'common': [u'target.common.tests.zip'], 20:36:02 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 20:36:02 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 20:36:02 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 20:36:02 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 20:36:02 INFO - u'mozbase': [u'target.common.tests.zip'], 20:36:02 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 20:36:02 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 20:36:02 INFO - u'web-platform': [u'target.common.tests.zip', 20:36:02 INFO - u'target.web-platform.tests.zip'], 20:36:02 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 20:36:02 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 20:36:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.common.tests.zip 20:36:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:36:02 INFO - Fetch https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.common.tests.zip into memory 20:36:04 INFO - Content-Length response header: 58438812 20:36:04 INFO - Bytes received: 58438812 20:36:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 20:36:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.common.tests.zip 20:36:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:36:13 INFO - Fetch https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.common.tests.zip into memory 20:36:15 INFO - Content-Length response header: 58438812 20:36:15 INFO - Bytes received: 58438812 20:36:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.talos.tests.zip 20:36:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 20:36:26 INFO - Fetch https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.talos.tests.zip into memory 20:36:27 INFO - Content-Length response header: 14409362 20:36:27 INFO - Bytes received: 14409362 20:36:27 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')]} 20:36:27 INFO - trying https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.tar.bz2 20:36:27 INFO - Downloading https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 20:36:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 20:36:30 INFO - Downloaded 58255597 bytes. 20:36:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.tar.bz2 20:36:30 INFO - mkdir: /builds/slave/test/properties 20:36:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:36:30 INFO - Writing to file /builds/slave/test/properties/build_url 20:36:30 INFO - Contents: 20:36:30 INFO - build_url:https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.tar.bz2 20:36:30 INFO - Running post-action listener: _resource_record_post_action 20:36:30 INFO - Running post-action listener: set_extra_try_arguments 20:36:30 INFO - [mozharness: 2017-05-08 03:36:30.125302Z] Finished download-and-extract step (success) 20:36:30 INFO - [mozharness: 2017-05-08 03:36:30.125415Z] Running populate-webroot step. 20:36:30 INFO - Running pre-action listener: _resource_record_pre_action 20:36:30 INFO - Running main action method: populate_webroot 20:36:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:36:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:36:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:36:30 INFO - '--tppagecycles', 20:36:30 INFO - '7'], 20:36:30 INFO - 'tests': ['tsvgm']}}, 20:36:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:36:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:36:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:36:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:36:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:36:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:36:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:36:30 INFO - 'talos_options': ['--disable-e10s'], 20:36:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:36:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:36:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:36:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:36:30 INFO - 'talos_options': ['--disable-e10s'], 20:36:30 INFO - 'tests': ['damp', 'tps']}, 20:36:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:36:30 INFO - 'tests': ['damp', 'tps']}, 20:36:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:36:30 INFO - 'tests': ['dromaeo_dom']}, 20:36:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:36:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:36:30 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 20:36:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 20:36:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:36:30 INFO - 'tests': ['a11yr', 20:36:30 INFO - 'ts_paint', 20:36:30 INFO - 'tpaint', 20:36:30 INFO - 'sessionrestore', 20:36:30 INFO - 'sessionrestore_no_auto_restore', 20:36:30 INFO - 'tabpaint']}, 20:36:30 INFO - 'other-e10s': {'tests': ['a11yr', 20:36:30 INFO - 'ts_paint', 20:36:30 INFO - 'tpaint', 20:36:30 INFO - 'sessionrestore', 20:36:30 INFO - 'sessionrestore_no_auto_restore', 20:36:30 INFO - 'tabpaint']}, 20:36:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:36:30 INFO - 'ts_paint', 20:36:30 INFO - 'tpaint', 20:36:30 INFO - 'sessionrestore', 20:36:30 INFO - 'sessionrestore_no_auto_restore', 20:36:30 INFO - 'tabpaint']}, 20:36:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:36:30 INFO - 'ts_paint', 20:36:30 INFO - 'tpaint', 20:36:30 INFO - 'sessionrestore', 20:36:30 INFO - 'sessionrestore_no_auto_restore', 20:36:30 INFO - 'tabpaint']}, 20:36:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:36:30 INFO - 'tests': ['a11yr', 20:36:30 INFO - 'ts_paint', 20:36:30 INFO - 'tpaint', 20:36:30 INFO - 'sessionrestore', 20:36:30 INFO - 'sessionrestore_no_auto_restore', 20:36:30 INFO - 'tabpaint']}, 20:36:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:36:30 INFO - 'tests': ['a11yr', 20:36:30 INFO - 'ts_paint', 20:36:30 INFO - 'tpaint', 20:36:30 INFO - 'sessionrestore', 20:36:30 INFO - 'sessionrestore_no_auto_restore', 20:36:30 INFO - 'tabpaint']}, 20:36:30 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 20:36:30 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 20:36:30 INFO - 'bloom_basic_ref']}, 20:36:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:36:30 INFO - 'tests': ['tsvgx', 20:36:30 INFO - 'tsvgr_opacity', 20:36:30 INFO - 'tart', 20:36:30 INFO - 'tscrollx', 20:36:30 INFO - 'cart', 20:36:30 INFO - 'tsvg_static']}, 20:36:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:36:30 INFO - 'tsvgr_opacity', 20:36:30 INFO - 'tart', 20:36:30 INFO - 'tscrollx', 20:36:30 INFO - 'cart', 20:36:30 INFO - 'tsvg_static']}, 20:36:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:36:30 INFO - 'talos_options': ['--disable-e10s'], 20:36:30 INFO - 'tests': ['tp5o']}, 20:36:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:36:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:36:30 INFO - 'talos_options': ['--disable-e10s', 20:36:30 INFO - '--xperf_path', 20:36:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:36:30 INFO - 'tests': ['tp5n']}, 20:36:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:36:30 INFO - 'talos_options': ['--xperf_path', 20:36:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:36:30 INFO - 'tests': ['tp5n']}}, 20:36:30 INFO - 'talos.zip': {'path': '', 20:36:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:36:30 INFO - Running post-action listener: _resource_record_post_action 20:36:30 INFO - [mozharness: 2017-05-08 03:36:30.142240Z] Finished populate-webroot step (success) 20:36:30 INFO - [mozharness: 2017-05-08 03:36:30.142329Z] Running create-virtualenv step. 20:36:30 INFO - Running pre-action listener: _resource_record_pre_action 20:36:30 INFO - Running main action method: create_virtualenv 20:36:30 INFO - Creating virtualenv /builds/slave/test/build/venv 20:36:30 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 20:36:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:36:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:36:30 INFO - Using real prefix '/usr' 20:36:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:36:30 INFO - Installing distribute.............................................................................................................................................................................................done. 20:36:32 INFO - Installing pip.................done. 20:36:32 INFO - Return code: 0 20:36:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:36:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:36:33 INFO - Reading from file tmpfile_stdout 20:36:33 INFO - Output received: 20:36:33 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) 20:36:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:36:33 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')]} 20:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:33 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')]} 20:36:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:33 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 0x15ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1786a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1929a30>, '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 0x192a7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192aca0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063', '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 20:36:33 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 20:36:33 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 20:36:33 INFO - Using env: {'DISPLAY': ':0', 20:36:33 INFO - 'HOME': '/home/cltbld', 20:36:33 INFO - 'LANG': 'en_US.UTF-8', 20:36:33 INFO - 'LANGUAGE': 'en_US:en', 20:36:33 INFO - 'LOGNAME': 'cltbld', 20:36:33 INFO - 'MAIL': '/var/mail/cltbld', 20:36:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:33 INFO - 'MOZ_NO_REMOTE': '1', 20:36:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:33 INFO - 'NO_EM_RESTART': '1', 20:36:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:33 INFO - 'PWD': '/builds/slave/test', 20:36:33 INFO - 'SHELL': '/bin/bash', 20:36:33 INFO - 'SHLVL': '1', 20:36:33 INFO - 'TERM': 'linux', 20:36:33 INFO - 'TMOUT': '86400', 20:36:33 INFO - 'USER': 'cltbld', 20:36:33 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063', 20:36:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:33 INFO - '_': '/tools/buildbot/bin/python'} 20:36:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:33 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 20:36:33 INFO - Cleaning up... 20:36:33 INFO - Return code: 0 20:36:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:36:33 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')]} 20:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:33 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')]} 20:36:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:33 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 0x15ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1786a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1929a30>, '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 0x192a7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192aca0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063', '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 20:36:33 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 20:36:33 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 20:36:33 INFO - Using env: {'DISPLAY': ':0', 20:36:33 INFO - 'HOME': '/home/cltbld', 20:36:33 INFO - 'LANG': 'en_US.UTF-8', 20:36:33 INFO - 'LANGUAGE': 'en_US:en', 20:36:33 INFO - 'LOGNAME': 'cltbld', 20:36:33 INFO - 'MAIL': '/var/mail/cltbld', 20:36:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:33 INFO - 'MOZ_NO_REMOTE': '1', 20:36:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:33 INFO - 'NO_EM_RESTART': '1', 20:36:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:33 INFO - 'PWD': '/builds/slave/test', 20:36:33 INFO - 'SHELL': '/bin/bash', 20:36:33 INFO - 'SHLVL': '1', 20:36:33 INFO - 'TERM': 'linux', 20:36:33 INFO - 'TMOUT': '86400', 20:36:33 INFO - 'USER': 'cltbld', 20:36:33 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063', 20:36:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:33 INFO - '_': '/tools/buildbot/bin/python'} 20:36:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:33 INFO - Downloading/unpacking psutil>=3.1.1 20:36:33 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 20:36:33 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 20:36:33 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 20:36:33 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 20:36:33 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 20:36:33 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 20:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:36:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:36:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:36:34 INFO - Installing collected packages: psutil 20:36:34 INFO - Running setup.py install for psutil 20:36:34 INFO - building 'psutil._psutil_linux' extension 20:36:34 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 20:36:35 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 20:36:35 INFO - building 'psutil._psutil_posix' extension 20:36:35 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 20:36:36 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 20:36:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:36:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:36:36 INFO - Successfully installed psutil 20:36:36 INFO - Cleaning up... 20:36:36 INFO - Return code: 0 20:36:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:36: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')]} 20:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36: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')]} 20:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1786a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1929a30>, '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 0x192a7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192aca0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063', '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 20:36: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:36: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 mozsystemmonitor==0.3 20:36:36 INFO - Using env: {'DISPLAY': ':0', 20:36:36 INFO - 'HOME': '/home/cltbld', 20:36:36 INFO - 'LANG': 'en_US.UTF-8', 20:36:36 INFO - 'LANGUAGE': 'en_US:en', 20:36:36 INFO - 'LOGNAME': 'cltbld', 20:36:36 INFO - 'MAIL': '/var/mail/cltbld', 20:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:36 INFO - 'MOZ_NO_REMOTE': '1', 20:36:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:36 INFO - 'NO_EM_RESTART': '1', 20:36:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:36 INFO - 'PWD': '/builds/slave/test', 20:36:36 INFO - 'SHELL': '/bin/bash', 20:36:36 INFO - 'SHLVL': '1', 20:36:36 INFO - 'TERM': 'linux', 20:36:36 INFO - 'TMOUT': '86400', 20:36:36 INFO - 'USER': 'cltbld', 20:36:36 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063', 20:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:36 INFO - '_': '/tools/buildbot/bin/python'} 20:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:36: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 20:36: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 20:36: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 20:36: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 20:36: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 20:36: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 20:36:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:36:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:36:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:36:37 INFO - Installing collected packages: mozsystemmonitor 20:36:37 INFO - Running setup.py install for mozsystemmonitor 20:36:37 INFO - Successfully installed mozsystemmonitor 20:36:37 INFO - Cleaning up... 20:36:37 INFO - Return code: 0 20:36:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:37 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 0x15ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1786a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1929a30>, '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 0x192a7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192aca0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063', '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 20:36:37 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 20:36:37 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 20:36:37 INFO - Using env: {'DISPLAY': ':0', 20:36:37 INFO - 'HOME': '/home/cltbld', 20:36:37 INFO - 'LANG': 'en_US.UTF-8', 20:36:37 INFO - 'LANGUAGE': 'en_US:en', 20:36:37 INFO - 'LOGNAME': 'cltbld', 20:36:37 INFO - 'MAIL': '/var/mail/cltbld', 20:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:37 INFO - 'MOZ_NO_REMOTE': '1', 20:36:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:37 INFO - 'NO_EM_RESTART': '1', 20:36:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:37 INFO - 'PWD': '/builds/slave/test', 20:36:37 INFO - 'SHELL': '/bin/bash', 20:36:37 INFO - 'SHLVL': '1', 20:36:37 INFO - 'TERM': 'linux', 20:36:37 INFO - 'TMOUT': '86400', 20:36:37 INFO - 'USER': 'cltbld', 20:36:37 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063', 20:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:37 INFO - '_': '/tools/buildbot/bin/python'} 20:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:37 INFO - Downloading/unpacking jsonschema==2.5.1 20:36:37 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 20:36:37 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 20:36:37 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 20:36:37 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 20:36:37 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 20:36:37 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 20:36:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:36:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:36:38 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 20:36:38 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 20:36:38 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 20:36:38 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 20:36:38 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 20:36:38 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 20:36:39 INFO - Downloading functools32-3.2.3-2.tar.gz 20:36:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:36:39 INFO - warning: no files found matching '*.txt' 20:36:39 INFO - no previously-included directories found matching 'build' 20:36:39 INFO - no previously-included directories found matching 'dist' 20:36:39 INFO - no previously-included directories found matching '.git*' 20:36:39 INFO - Installing collected packages: jsonschema, functools32 20:36:39 INFO - Running setup.py install for functools32 20:36:39 INFO - warning: no files found matching '*.txt' 20:36:39 INFO - no previously-included directories found matching 'build' 20:36:39 INFO - no previously-included directories found matching 'dist' 20:36:39 INFO - no previously-included directories found matching '.git*' 20:36:39 INFO - Successfully installed jsonschema functools32 20:36:39 INFO - Cleaning up... 20:36:39 INFO - Return code: 0 20:36:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:36: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')]} 20:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36: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')]} 20:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36: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', '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 0x15ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1786a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1929a30>, '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 0x192a7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192aca0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063', '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 20:36: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:36: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 functools32==3.2.3-2 20:36:39 INFO - Using env: {'DISPLAY': ':0', 20:36:39 INFO - 'HOME': '/home/cltbld', 20:36:39 INFO - 'LANG': 'en_US.UTF-8', 20:36:39 INFO - 'LANGUAGE': 'en_US:en', 20:36:39 INFO - 'LOGNAME': 'cltbld', 20:36:39 INFO - 'MAIL': '/var/mail/cltbld', 20:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:39 INFO - 'MOZ_NO_REMOTE': '1', 20:36:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:39 INFO - 'NO_EM_RESTART': '1', 20:36:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:39 INFO - 'PWD': '/builds/slave/test', 20:36:39 INFO - 'SHELL': '/bin/bash', 20:36:39 INFO - 'SHLVL': '1', 20:36:39 INFO - 'TERM': 'linux', 20:36:39 INFO - 'TMOUT': '86400', 20:36:39 INFO - 'USER': 'cltbld', 20:36:39 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063', 20:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:39 INFO - '_': '/tools/buildbot/bin/python'} 20:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:36:39 INFO - Cleaning up... 20:36:39 INFO - Return code: 0 20:36:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:36: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')]} 20:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36: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')]} 20:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36: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', '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 0x15ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1786a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1929a30>, '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 0x192a7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192aca0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063', '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 20:36: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:36: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 blobuploader==1.2.4 20:36:39 INFO - Using env: {'DISPLAY': ':0', 20:36:39 INFO - 'HOME': '/home/cltbld', 20:36:39 INFO - 'LANG': 'en_US.UTF-8', 20:36:39 INFO - 'LANGUAGE': 'en_US:en', 20:36:39 INFO - 'LOGNAME': 'cltbld', 20:36:39 INFO - 'MAIL': '/var/mail/cltbld', 20:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:39 INFO - 'MOZ_NO_REMOTE': '1', 20:36:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:39 INFO - 'NO_EM_RESTART': '1', 20:36:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:39 INFO - 'PWD': '/builds/slave/test', 20:36:39 INFO - 'SHELL': '/bin/bash', 20:36:39 INFO - 'SHLVL': '1', 20:36:39 INFO - 'TERM': 'linux', 20:36:39 INFO - 'TMOUT': '86400', 20:36:39 INFO - 'USER': 'cltbld', 20:36:39 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063', 20:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:39 INFO - '_': '/tools/buildbot/bin/python'} 20:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:39 INFO - Downloading/unpacking blobuploader==1.2.4 20:36: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 20:36: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 20:36: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 20:36: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 20:36: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 20:36: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 20:36:40 INFO - Downloading blobuploader-1.2.4.tar.gz 20:36:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:36:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:36:40 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 20:36:40 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 20:36:40 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 20:36:40 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 20:36:40 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 20:36:40 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 20:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:36:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:36:41 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 20:36:41 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 20:36:41 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 20:36:41 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 20:36:41 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 20:36:41 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 20:36:41 INFO - Downloading docopt-0.6.1.tar.gz 20:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:36:41 INFO - Installing collected packages: blobuploader, requests, docopt 20:36:41 INFO - Running setup.py install for blobuploader 20:36:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:36:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:36:41 INFO - Running setup.py install for requests 20:36:41 INFO - Running setup.py install for docopt 20:36:42 INFO - Successfully installed blobuploader requests docopt 20:36:42 INFO - Cleaning up... 20:36:42 INFO - Return code: 0 20:36:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:36:42 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')]} 20:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:42 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')]} 20:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:42 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 0x15ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1786a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1929a30>, '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 0x192a7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192aca0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063', '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 20:36:42 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 20:36:42 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 20:36:42 INFO - Using env: {'DISPLAY': ':0', 20:36:42 INFO - 'HOME': '/home/cltbld', 20:36:42 INFO - 'LANG': 'en_US.UTF-8', 20:36:42 INFO - 'LANGUAGE': 'en_US:en', 20:36:42 INFO - 'LOGNAME': 'cltbld', 20:36:42 INFO - 'MAIL': '/var/mail/cltbld', 20:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:42 INFO - 'MOZ_NO_REMOTE': '1', 20:36:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:42 INFO - 'NO_EM_RESTART': '1', 20:36:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:42 INFO - 'PWD': '/builds/slave/test', 20:36:42 INFO - 'SHELL': '/bin/bash', 20:36:42 INFO - 'SHLVL': '1', 20:36:42 INFO - 'TERM': 'linux', 20:36:42 INFO - 'TMOUT': '86400', 20:36:42 INFO - 'USER': 'cltbld', 20:36:42 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063', 20:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:42 INFO - '_': '/tools/buildbot/bin/python'} 20:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:36:42 INFO - Running setup.py (path:/tmp/pip-k_tga7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:36:42 INFO - Running setup.py (path:/tmp/pip-E6jkVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:36:42 INFO - Running setup.py (path:/tmp/pip-RHiqEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:36:42 INFO - Running setup.py (path:/tmp/pip-yV2NuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:36:42 INFO - Running setup.py (path:/tmp/pip-DD1h5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:36:42 INFO - Running setup.py (path:/tmp/pip-wjRy4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:36:42 INFO - Running setup.py (path:/tmp/pip-VK5Emp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:36:42 INFO - Running setup.py (path:/tmp/pip-R_ekba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:36:42 INFO - Running setup.py (path:/tmp/pip-5aizPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:36:42 INFO - Running setup.py (path:/tmp/pip-7Czy7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:36:43 INFO - Running setup.py (path:/tmp/pip-jrXmcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:36:43 INFO - Running setup.py (path:/tmp/pip-lx_haN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:36:43 INFO - Running setup.py (path:/tmp/pip-aMgSWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:36:43 INFO - Running setup.py (path:/tmp/pip-_CFL0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:36:43 INFO - Running setup.py (path:/tmp/pip-MWKdR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:36:43 INFO - Running setup.py (path:/tmp/pip-d9HBcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:36:43 INFO - Running setup.py (path:/tmp/pip-HLPqrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:36:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:36:43 INFO - Running setup.py install for manifestparser 20:36:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:36:43 INFO - Running setup.py install for mozcrash 20:36:43 INFO - Running setup.py install for mozdebug 20:36:43 INFO - Running setup.py install for mozdevice 20:36:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:36:43 INFO - Running setup.py install for mozfile 20:36:44 INFO - Running setup.py install for mozhttpd 20:36:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:36:44 INFO - Running setup.py install for mozinfo 20:36:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:36:44 INFO - Running setup.py install for mozInstall 20:36:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:36:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:36:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:36:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:36:44 INFO - Running setup.py install for mozleak 20:36:44 INFO - Running setup.py install for mozlog 20:36:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:36:44 INFO - Running setup.py install for moznetwork 20:36:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:36:44 INFO - Running setup.py install for mozprocess 20:36:44 INFO - Running setup.py install for mozprofile 20:36:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:36:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:36:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:36:44 INFO - Running setup.py install for mozrunner 20:36:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:36:45 INFO - Running setup.py install for mozscreenshot 20:36:45 INFO - Running setup.py install for moztest 20:36:45 INFO - Running setup.py install for mozversion 20:36:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:36:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:36:45 INFO - Cleaning up... 20:36:45 INFO - Return code: 0 20:36:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:36:45 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')]} 20:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:45 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')]} 20:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:45 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 0x15ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1786a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1929a30>, '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 0x192a7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192aca0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063', '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 20:36:45 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 20:36:45 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 20:36:45 INFO - Using env: {'DISPLAY': ':0', 20:36:45 INFO - 'HOME': '/home/cltbld', 20:36:45 INFO - 'LANG': 'en_US.UTF-8', 20:36:45 INFO - 'LANGUAGE': 'en_US:en', 20:36:45 INFO - 'LOGNAME': 'cltbld', 20:36:45 INFO - 'MAIL': '/var/mail/cltbld', 20:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:45 INFO - 'MOZ_NO_REMOTE': '1', 20:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:45 INFO - 'NO_EM_RESTART': '1', 20:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:45 INFO - 'PWD': '/builds/slave/test', 20:36:45 INFO - 'SHELL': '/bin/bash', 20:36:45 INFO - 'SHLVL': '1', 20:36:45 INFO - 'TERM': 'linux', 20:36:45 INFO - 'TMOUT': '86400', 20:36:45 INFO - 'USER': 'cltbld', 20:36:45 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063', 20:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:45 INFO - '_': '/tools/buildbot/bin/python'} 20:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:36:45 INFO - Running setup.py (path:/tmp/pip-tAQQG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:36:45 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)) 20:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:36:45 INFO - Running setup.py (path:/tmp/pip-MLZGOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:36:45 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)) 20:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:36:45 INFO - Running setup.py (path:/tmp/pip-6LhAZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:36:45 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)) 20:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:36:45 INFO - Running setup.py (path:/tmp/pip-32zj72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:36:45 INFO - Running setup.py (path:/tmp/pip-myTU4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:36:45 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)) 20:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:36:45 INFO - Running setup.py (path:/tmp/pip-mQqoqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:36:45 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)) 20:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:36:45 INFO - Running setup.py (path:/tmp/pip-cNldfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:36:46 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)) 20:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:36:46 INFO - Running setup.py (path:/tmp/pip-wVMGOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:36:46 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)) 20:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:36:46 INFO - Running setup.py (path:/tmp/pip-brQZMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:36:46 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)) 20:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:36:46 INFO - Running setup.py (path:/tmp/pip-6yjOYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:36:46 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)) 20:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:36:46 INFO - Running setup.py (path:/tmp/pip-G_noSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:36:46 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)) 20:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:36:46 INFO - Running setup.py (path:/tmp/pip-nNW65n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:36:46 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)) 20:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:36:46 INFO - Running setup.py (path:/tmp/pip-3cSseF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:36:46 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)) 20:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:36:46 INFO - Running setup.py (path:/tmp/pip-NKxh_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:36:46 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)) 20:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:36:46 INFO - Running setup.py (path:/tmp/pip-ADYgDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:36:46 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)) 20:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:36:46 INFO - Running setup.py (path:/tmp/pip-wPdV_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:36:46 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)) 20:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:36:46 INFO - Running setup.py (path:/tmp/pip-5GDrVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:36:46 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)) 20:36:46 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)) 20:36:46 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)) 20:36:46 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)) 20:36:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:36:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:36:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:36:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:36:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:36:47 INFO - Downloading blessings-1.6.tar.gz 20:36:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:36:47 INFO - Installing collected packages: blessings 20:36:47 INFO - Running setup.py install for blessings 20:36:48 INFO - Successfully installed blessings 20:36:48 INFO - Cleaning up... 20:36:48 INFO - Return code: 0 20:36:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:36:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:36:48 INFO - Reading from file tmpfile_stdout 20:36:48 INFO - Current package versions: 20:36:48 INFO - argparse == 1.2.1 20:36:48 INFO - blessings == 1.6 20:36:48 INFO - blobuploader == 1.2.4 20:36:48 INFO - docopt == 0.6.1 20:36:48 INFO - functools32 == 3.2.3-2 20:36:48 INFO - jsonschema == 2.5.1 20:36:48 INFO - manifestparser == 1.1 20:36:48 INFO - mozInstall == 1.12 20:36:48 INFO - mozcrash == 1.0 20:36:48 INFO - mozdebug == 0.1 20:36:48 INFO - mozdevice == 0.50 20:36:48 INFO - mozfile == 1.2 20:36:48 INFO - mozhttpd == 0.7 20:36:48 INFO - mozinfo == 0.9 20:36:48 INFO - mozleak == 0.1 20:36:48 INFO - mozlog == 3.4 20:36:48 INFO - moznetwork == 0.27 20:36:48 INFO - mozprocess == 0.25 20:36:48 INFO - mozprofile == 0.28 20:36:48 INFO - mozrunner == 6.13 20:36:48 INFO - mozscreenshot == 0.1 20:36:48 INFO - mozsystemmonitor == 0.3 20:36:48 INFO - moztest == 0.8 20:36:48 INFO - mozversion == 1.4 20:36:48 INFO - psutil == 3.1.1 20:36:48 INFO - requests == 1.2.3 20:36:48 INFO - wsgiref == 0.1.2 20:36:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:36: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')]} 20:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36: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')]} 20:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:48 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 0x15ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1786a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1929a30>, '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 0x192a7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192aca0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063', '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 20:36:48 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 20:36:48 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 20:36:48 INFO - Using env: {'DISPLAY': ':0', 20:36:48 INFO - 'HOME': '/home/cltbld', 20:36:48 INFO - 'LANG': 'en_US.UTF-8', 20:36:48 INFO - 'LANGUAGE': 'en_US:en', 20:36:48 INFO - 'LOGNAME': 'cltbld', 20:36:48 INFO - 'MAIL': '/var/mail/cltbld', 20:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:48 INFO - 'MOZ_NO_REMOTE': '1', 20:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:48 INFO - 'NO_EM_RESTART': '1', 20:36:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:48 INFO - 'PWD': '/builds/slave/test', 20:36:48 INFO - 'SHELL': '/bin/bash', 20:36:48 INFO - 'SHLVL': '1', 20:36:48 INFO - 'TERM': 'linux', 20:36:48 INFO - 'TMOUT': '86400', 20:36:48 INFO - 'USER': 'cltbld', 20:36:48 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063', 20:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:48 INFO - '_': '/tools/buildbot/bin/python'} 20:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:48 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)) 20:36:48 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)) 20:36:48 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)) 20:36:48 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)) 20:36:48 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)) 20:36:48 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)) 20:36:48 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)) 20:36:48 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)) 20:36:48 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)) 20:36:48 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)) 20:36:48 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)) 20:36:48 INFO - Cleaning up... 20:36:48 INFO - Return code: 0 20:36:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:36: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')]} 20:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36: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')]} 20:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1786a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1929a30>, '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 0x192a7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192aca0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063', '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 20:36:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:36:48 INFO - Using env: {'DISPLAY': ':0', 20:36:48 INFO - 'HOME': '/home/cltbld', 20:36:48 INFO - 'LANG': 'en_US.UTF-8', 20:36:48 INFO - 'LANGUAGE': 'en_US:en', 20:36:48 INFO - 'LOGNAME': 'cltbld', 20:36:48 INFO - 'MAIL': '/var/mail/cltbld', 20:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:48 INFO - 'MOZ_NO_REMOTE': '1', 20:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:48 INFO - 'NO_EM_RESTART': '1', 20:36:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:48 INFO - 'PWD': '/builds/slave/test', 20:36:48 INFO - 'SHELL': '/bin/bash', 20:36:48 INFO - 'SHLVL': '1', 20:36:48 INFO - 'TERM': 'linux', 20:36:48 INFO - 'TMOUT': '86400', 20:36:48 INFO - 'USER': 'cltbld', 20:36:48 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063', 20:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:48 INFO - '_': '/tools/buildbot/bin/python'} 20:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:36:48 INFO - Cleaning up... 20:36:48 INFO - Return code: 0 20:36:48 INFO - Running post-action listener: _resource_record_post_action 20:36:48 INFO - Running post-action listener: _start_resource_monitoring 20:36:48 INFO - Starting resource monitoring. 20:36:48 INFO - [mozharness: 2017-05-08 03:36:48.796659Z] Finished create-virtualenv step (success) 20:36:48 INFO - [mozharness: 2017-05-08 03:36:48.797121Z] Running install step. 20:36:48 INFO - Running pre-action listener: _resource_record_pre_action 20:36:48 INFO - Running main action method: install 20:36:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:36:49 INFO - Reading from file tmpfile_stdout 20:36:49 INFO - Detecting whether we're running mozinstall >=1.0... 20:36:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:36:49 INFO - Reading from file tmpfile_stdout 20:36:49 INFO - Output received: 20:36:49 INFO - Usage: mozinstall [options] installer 20:36:49 INFO - Options: 20:36:49 INFO - -h, --help show this help message and exit 20:36:49 INFO - -d DEST, --destination=DEST 20:36:49 INFO - Directory to install application into. [default: 20:36:49 INFO - "/builds/slave/test"] 20:36:49 INFO - --app=APP Application being installed. [default: firefox] 20:36:49 INFO - mkdir: /builds/slave/test/build/application 20:36:49 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'] 20:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 20:37:03 INFO - Reading from file tmpfile_stdout 20:37:03 INFO - Output received: 20:37:03 INFO - /builds/slave/test/build/application/firefox/firefox 20:37:03 INFO - Running post-action listener: _resource_record_post_action 20:37:03 INFO - [mozharness: 2017-05-08 03:37:03.903869Z] Finished install step (success) 20:37:03 INFO - [mozharness: 2017-05-08 03:37:03.904146Z] Running run-tests step. 20:37:03 INFO - Running pre-action listener: _resource_record_pre_action 20:37:03 INFO - Running main action method: run_tests 20:37:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:37:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:37:03 INFO - Python 2.7.3 20:37:03 INFO - Return code: 0 20:37:03 INFO - grabbing minidump binary from tooltool 20:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:37:03 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 0x1929a30>, '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 0x192a7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192aca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:37:03 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 20:37:03 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 20:37:03 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 20:37:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:37:04 INFO - Return code: 0 20:37:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:37:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:37:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:37:04 INFO - ENV: RUST_BACKTRACE is now 1 20:37:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:37:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:37:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-074', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:37:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-074 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:37:04 INFO - Using env: {'DISPLAY': ':0', 20:37:04 INFO - 'HOME': '/home/cltbld', 20:37:04 INFO - 'LANG': 'en_US.UTF-8', 20:37:04 INFO - 'LANGUAGE': 'en_US:en', 20:37:04 INFO - 'LOGNAME': 'cltbld', 20:37:04 INFO - 'MAIL': '/var/mail/cltbld', 20:37:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:37:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:37:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:04 INFO - 'MOZ_NO_REMOTE': '1', 20:37:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:37:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:37:04 INFO - 'NO_EM_RESTART': '1', 20:37:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:37:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:04 INFO - 'PWD': '/builds/slave/test', 20:37:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:37:04 INFO - 'RUST_BACKTRACE': '1', 20:37:04 INFO - 'SHELL': '/bin/bash', 20:37:04 INFO - 'SHLVL': '1', 20:37:04 INFO - 'TERM': 'linux', 20:37:04 INFO - 'TMOUT': '86400', 20:37:04 INFO - 'USER': 'cltbld', 20:37:04 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063', 20:37:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:04 INFO - '_': '/tools/buildbot/bin/python'} 20:37:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-074', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:37:04 INFO - mozversion application_buildid: 20170508031038 20:37:04 INFO - mozversion application_changeset: 22aaf8bad4df8e5f8c976f1521c213cb37e2dff5 20:37:04 INFO - mozversion application_display_name: Nightly 20:37:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:37:04 INFO - mozversion application_name: Firefox 20:37:04 INFO - mozversion application_remotingname: firefox 20:37:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:37:04 INFO - mozversion application_vendor: Mozilla 20:37:04 INFO - mozversion application_version: 55.0a1 20:37:04 INFO - mozversion platform_buildid: 20170508031038 20:37:04 INFO - mozversion platform_changeset: 22aaf8bad4df8e5f8c976f1521c213cb37e2dff5 20:37:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:37:04 INFO - mozversion platform_version: 55.0a1 20:37:04 INFO - using testdate: 1494214624 20:37:04 INFO - actual date: 1494214624 20:37:04 INFO - starting webserver on 'localhost:36701' 20:37:04 INFO - SUITE-START | Running 2 tests 20:37:04 INFO - TEST-START | dromaeo_css 20:37:04 INFO - operating with platform_type : linux_ 20:37:04 INFO - Initialising browser for dromaeo_css test... 20:37:04 INFO - TEST-INFO | started process 3334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDcBPg0/profile http://localhost:36701/getInfo.html) 20:37:09 INFO - PID 3334 | __metrics Screen width/height:1600/1200 20:37:09 INFO - PID 3334 | colorDepth:24 20:37:09 INFO - PID 3334 | Browser inner width/height: 1024/695 20:37:09 INFO - PID 3334 | __metrics 20:37:11 INFO - TEST-INFO | 3334: exit 0 20:37:11 INFO - Browser initialized. 20:37:11 INFO - Running cycle 1/1 for dromaeo_css test... 20:37:11 INFO - TEST-INFO | started process 3506 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDcBPg0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:37:23 INFO - PID 3506 | RSS: Main: 159764480 20:37:23 INFO - PID 3506 | 20:40:28 INFO - PID 3506 | Cycle 1(1): loaded http://localhost:36701/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36701/tests/dromaeo/cssquery-ext.html) 20:40:31 INFO - PID 3506 | RSS: Main: 165167104 20:40:31 INFO - PID 3506 | 20:43:33 INFO - PID 3506 | Cycle 1(1): loaded http://localhost:36701/tests/dromaeo/cssquery-ext.html (next: http://localhost:36701/tests/dromaeo/cssquery-jquery.html) 20:43:33 INFO - PID 3506 | RSS: Main: 158806016 20:43:33 INFO - PID 3506 | 20:46:35 INFO - PID 3506 | Cycle 1(1): loaded http://localhost:36701/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36701/tests/dromaeo/cssquery-mootools.html) 20:46:36 INFO - PID 3506 | RSS: Main: 166952960 20:46:36 INFO - PID 3506 | 20:49:38 INFO - PID 3506 | Cycle 1(1): loaded http://localhost:36701/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36701/tests/dromaeo/cssquery-prototype.html) 20:49:38 INFO - PID 3506 | RSS: Main: 159019008 20:49:38 INFO - PID 3506 | 20:52:41 INFO - PID 3506 | Cycle 1(1): loaded http://localhost:36701/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36701/tests/dromaeo/cssquery-yui.html) 20:52:42 INFO - PID 3506 | RSS: Main: 163385344 20:52:42 INFO - PID 3506 | 20:55:44 INFO - PID 3506 | Cycle 1(1): loaded http://localhost:36701/tests/dromaeo/cssquery-yui.html (next: http://localhost:36701/tests/dromaeo/cssquery-dojo.html) 20:55:44 INFO - PID 3506 | RSS: Main: 166293504 20:55:44 INFO - PID 3506 | 20:55:44 INFO - PID 3506 | __start_tp_report 20:55:44 INFO - PID 3506 | _x_x_mozilla_page_load 20:55:44 INFO - PID 3506 | _x_x_mozilla_page_load_details 20:55:44 INFO - PID 3506 | |i|pagename|runs| 20:55:44 INFO - PID 3506 | |0;dojo.html;2738.630284911537;2750.7799376049916;2768.515509785787;2785.4986102501553;2790.916272511825;5240.475952404758;5315.388730296012;5326.414094449618;5333.200019996998;5397.190421436781;5275.894482110355;5295.629305948585;5322.308099947011;5364.168553874146;5398.2712333834925;4701.48283688794;4704.811807527695;4717.056588682261;4731.810727570893;4786.258129989839;4766.594839438651;4773.140834649762;4800.5679488846;4815.0610630926985;4819.277108433728;4600.677952543323;4667.066586682677;4674.626029917598;4676.766161691936;4729.054189162147;4680.321353403771;4696.178168820477;4698.130845793539;4699.859004229878;4721.315409265671;4656.41794775653;4656.743879086649;4660.4174478190225;4672.15901137795;4679.88300292492;5208.791648334062;5239.607029472767;5241.659292146036;5272.261883336336;5278.683279003272;5674.9716251418895;5699.2590963174935;5700.914486282709;5702.857428564277;5718.199452076713;5708.001099807517;5742.253507044099;5772.855678608026;5837.241158649391;5843.4448727371255;5208.869778255536;5214.713190774468;5219.921701174486;5269.235960785664;5274.736263186825;5700.914486282709;5755.1367294906095;5761.308642962787;5761.48146666802;5785.595008349375;5519.365272993577;5561.5272701820795;5621.353544342372;5644.238027866268;5741.397153298927;5558.833235002876;5662.68855212959;5665.801696940587;5718.228039214653;5745.13822926556;5597.608167428241;5621.98804215237;5627.943720562824;5651.632643878134;5665.858353541112;5580.609357345028;5614.859628509238;5636.070048441961;5639.464250896158;5694.5159661428415;4706.505816889246;4707.082118986833;4707.670463067552;4711.293306004127;4711.363965864564;4081.795910204478;4088.7751173685137;4099.487564054493;4110.321796903478;4111.280525907954;4710.9764451177525;4778.689385190021;4812.927806082912;4830.396200474941;4838.250071238964;4966.925496117561;5634.492895639412;5677.205191273225;5745.913811292834;5749.913751293734;4868.561829435368;4876.146674331978;4876.341693871353;4886.047220791983;4903.803847846046;5056.721880296619;5067.746612669352;5073.213651883964;5075.771590278447;5076.568491678248;5243.868903277448;5326.707031113326;5329.493698098674;5418.756155972912;5420.4850539198715;5753;5822.0684690449325;5822.912656310074;5825.76696932118;5867.178594996619;5316.468353164652;5366.7656439018465;5372.301600791872;5374.919376209438;5392.541633961;5551.833444996657;5647.915281270702;5651.915221271766;5656.462636049569;5687.118496633028;5660.009498337857;5665.12190610456;5665.3201615806365;5716.28546431696;5728.198052272768;5479.232907392889;5480.862978425412;5482.259894914295;5482.342118945752;5486.753096110764;5450.945490545044;5475.4250803665045;5486.862828429321;5505.944940550704;5519.530839878495;5438.129899216106;5464.23500709893;5485.75314110858;5488.286522752017;5489.780408783764;5502.972485137709;5541.445855414427;5548.389677135431;5553.888922221614;5563.082091455027;5472.425395333433;5514.779408823762;5542.418046105101;5549.916751248654;5560.36055853582 20:55:44 INFO - PID 3506 | |1;ext.html;719.4855678190095;738.2285511640337;1019.6176433837311;1057.5505410200662;1116.1573012375654;31255.374892502135;33951.32097358054;34191.658083419155;34405.48391774125;34415.31169376611;31850.68149318506;32122.196945076386;32182.839085804597;32190.35619287613;32240.193995150134;6332.68336583169;6405.135306733578;6434.581752186116;6530.379613936669;6533.444657204143;7067.611281379522;7165.570065796042;7173.354398104169;7176.677049532757;7183.317584829433;7150.356467917886;7184.784456466315;7196.1364636243725;7197.712091516333;7211.459140564452;7142.964285178593;7150.1777295611155;7160.28397160285;7166.713331466735;7204.171520275183;6967.059446974644;6980;6997.405220556258;7043.612601306926;7062.117235345582;32364.83817580897;32692.509612355832;32713.182170445692;32749.345013099606;32818;3089.3666798306294;3106.565080888655;3135.5139953307275;3143.7170654640963;3146.496560550301;25066;25129.371765705822;25138.748612513824;25275.11537096211;25373.873130634413;3124.297033167542;3136.278655909131;3174.984125079383;3176.571162893003;3188.85650145744;150731.2463437676;151470;151561;152097;152634;40045.79977100096;42179.57820421756;42992.35511467331;43256.35115473271;43345.34981975273;43241;43909.56090439055;43989.560104399185;44178.77910610491;44184.558154418686;13000.739985200244;13097.541586044443;13118.147320424141;13128.474861005643;13129.146605470614;9578.185854202331;9861.112499875046;9937.950310248403;10323.328983616191;10338.0695737384;12990.155639883378;12995.28525931064;13188.021796730376;13210.471581136839;13388.06283560161;5403.729813509309;5589.552835773128;5616.129499927518;5631.577631677641;5690.032694441955;876.1982785751094;910.8633704944311;919.0579655852804;922.077922077922;944.0889541592396;21556.353309400743;22637.88681056584;22698.205562805222;22701.20545780923;22999.770002300098;979.5396163803001;981.8821741391079;985.1380042462845;1007.8689770329956;1013.1995723378449;11510.712232194095;11845;11883.702907427383;11928.105392095627;11947.223430476992;176150;177265;178497;178655.10672446556;178702;42439.36340954888;42588.78705606514;42967.57032429636;42974.57025429768;43021.35467967983;1214.6052532926833;1230.2864338683721;1239.8822111899356;1244.321844594698;1250.2810883742068;20854.270100546408;20892.58214835725;21966;22058.558828823654;22059;31034.68965310318;31075.22311942129;31078;31171.220719481287;31361.529577055906;142736.2863185719;153885;154400.22799885928;154830;154847;32776.180595485304;32994.34011319808;33019.504707428925;33081.33837323288;33472.81589801275;36260;37546;39684.60315396809;39809.80095099622;39811.60188398079;27266.72733272642;27730.306742331602;28008.57987130154;28038.859805700842;28549.000784972428;28644.713552864203;28721.856390717912;28885.85557072201;29970.850145749133;30069.398612028075;32624.673753263112;32778.344433111684;32814;32846.507302390004;33028.50457243095;26888.865555672095;27884.76921846288;28005.859970700018;28019.299517512227;29665.588457327685;21473.57052858903;23182.3045308641;23258.76741232634;23267.418314541595;23369.883150584137 20:55:44 INFO - PID 3506 | |2;jquery.html;424.50148036313016;425.11788039817384;432.09907343189457;443.97780110994455;452.4864279043287;16754.832451675495;17328.306867725292;17794.73307900381;17915.372961946334;18256.361027364044;18498.167582458787;18598.163082661278;18759.812401875977;18928.905355473238;19267.229310827584;5414.756335964891;5446.15584584388;5561.110222364423;5598.720063996804;5618.073017952033;5463.808766693167;5505.807296744615;5528.308961379827;5528.585356098289;5529.447055294479;5339.279197308352;5366.892662146754;5392.973035134819;5396.1905714142995;5406.270153529283;5426.050441172819;5453.754581043842;5464.535514481274;5468.0977638689565;5492.395836457987;4840.225563909793;4972.6021918246815;4975.651704380694;4981.178105612606;5003.674761140514;21854.23510177152;21895.452613684785;21897.781022189734;21913;21940.122395104176;1607.9678406431922;1680.7646929429889;1692.7884014498188;1693.542743459259;1694.5594145522252;14959.40162393503;15026.398944042225;15135.167565783877;15283.465078722302;15417.229138543027;2086.3428020173596;2140.914363425461;2150.3656421355736;2164.3723320237114;2187.501561430425;81031;86861.56569217176;90702.5464872678;97310;99627.50186249023;11262.32426054423;11438.828417573743;11546.307221566733;11638.825417618742;11643;16176.191190440431;16184.19079046043;16208.189590520427;16236.350545978028;16265.349386024664;7210.927890721131;7429.62851857405;7439.144498382647;7616.466847320745;7647.891055796878;6688.966555167193;6693.564918280296;6882.311768823178;6909.239983601799;6922.238553759083;6949.166100068024;7137.500374973806;7150.606716630636;7205.423566114699;7207.747728829466;1942.2716481319505;1976.4465949534153;1989.6816509358432;2002.8698134621202;2192.1669765489332;851.2764150472173;893.1381217125376;893.5978809535735;899.1817446123996;917.2111983694018;17537.94940745441;17566.824331756517;18190.90904545495;18291.26834926588;18563.81436185621;893.3791015244343;894.4096896048577;900.0594378874092;902.4089221559889;924.089771574998;9719.17387022111;9829.508524573743;10113.241506886865;10214.233932455096;10294.073533382032;331916;333119;333898;339053;339106;73768;74623;76265.23734762693;76567;81131.5943420279;1091.8143915534379;1116.5757012335262;1128.8532490776147;1139.720768411728;1144.9255798373079;17558.29766809313;17667.911660441616;18215;18458.261669533604;18673.15970781345;38013.42979855249;38269;38424.03939901525;38609;39232.2153556933;51398;51593;51909.48090519047;52386.47613523816;54317;8236.588170591327;8445.690917907734;8510.744677659432;8636.481811091355;8669.739907802776;12608.810867836806;12723.427445764777;12946.546870859474;13084.214947103204;13561.79657305161;10884.12926965825;10988.230823842254;11144.777104457704;11312.773744525228;11583.594574189863;9946.751331216778;10788.136949043901;10808;10840.945795270973;10949.45252737344;11368.886311136783;11420.428978550874;11519.769604607693;11604.30374177552;11833.881661183623;8554.315654747481;8639.136086391562;8825.867611985697;8830.735077947671;8842.557872106241;11143.777124457627;11171.608993685182;11189.328640281608;11190.160737944523;11520 20:55:44 INFO - PID 3506 | |3;mootools.html;1213.2780995307794;1267.7020900088478;1275.6747029507474;1280.4302085571921;1290.6515240884967;9295.674651387195;9629.566669499873;9680.757981050469;9684.080012398828;9953.751156221098;9708.805823883518;9858.211343092553;9872.60509579616;9874.259430542703;9886.357386769854;2214.6013717530877;2233.039792889057;2238.3956331790405;2245.6070187717164;2247.1123906057096;2180.1388451561625;2207.4040009197506;2227.922022729205;2240.439890027493;2245.78665026823;2208.6355751301016;2221.7333919929633;2240.977590224093;2251.448395143192;2258.5934531784274;2114.6722258050027;2138.4546940530145;2175.0321107107425;2176.401489590375;2183.8471307008517;2072.6580114281123;2183.366823621148;2191.6822060801096;2221.911123555056;2225.899834507451;9710.271729620306;9735.610575576968;9751.658691945819;9775.804483910282;9777.217822574177;5316.308879845634;5501.14732216507;5531.2809334786625;5533.889322213573;5552.139418390156;3133.310671652233;3344.916377090568;3407.1993081625797;3410.693037626601;3410.795352278871;1103.7406209540752;1107.2968664897849;1124.5614210457927;1131.9943400283028;1144.1819099343925;13849.099808512516;13885.37515811791;13897;13966.58100256994;13974.554452970791;4690.525854644452;4739.454962679267;4831.057943700945;4911.0423467424225;4957.529034741694;10212.846807297896;10232.744181395525;10236.181105511541;10259;10262.230332725076;5536.916946245809;5565.026120428909;5566.359868615161;5574.052411090043;5582.8325150245555;5040.395152581714;5190.143626301618;5207.661502002357;5223.242629818655;5287.894242115136;3723.6090210528046;3823.4264860271182;3901.9804900975314;4002.3196056670436;4087.693422993228;1120.8262719278525;1141.6632093532428;1161;1164.441068287227;1168.7545615420686;683.4634811672813;690.5304393012699;699.2378307644692;717.3507975282378;719.1154879498247;5374.113271310268;6256.74973001084;6403.391677790602;6410.262819775786;6435.843992262551;835.3275613131366;840.7561807076002;847.7668641123616;869.7129947117436;871.3464901324007;3515.82420878955;3549.716022718176;3551.2187318789825;4202.495700515958;4588.541145885385;12094.758104837854;12624.936875315565;12647.936760316323;12703.428345724464;12704.745905081847;12253.816192757116;12571.1200215984;12601.306928118858;12666.430010649543;12777.93611031939;7012.0533727947095;7436.293552112541;7647.847043059108;7648.464607477535;7660.578668173192;6042.667653278936;6335.334789847;6341.55609107358;6412.647304398116;6547.312532184243;11049.668509944715;11318.94340528292;11564.653060408202;11565.653030409101;11576.305421674726;11074.39090850011;11276.718082048015;11318.094552435621;11452.484638191134;11498.655040348804;8019.759407217793;8146.2261085196815;8180.263776260165;8210.302124319262;8214.876776848472;9108.499032553273;9428.528573571157;9515.524223788645;9532.904670953201;9546.570404331684;7948.602569871599;7949.92050079515;7965.840683186188;8012.238837310446;8136.83726325482;7528.924710753042;7645.808854778675;7783.92216077832;7923.84152316962;7961.044674639081;6945.652717364213;7080.681369338495;7112.35988761014;7128.108986376703;7173.677184526605;5087.771050302819;5161.174212126042;5203.869903252449;5260.526552610283;5275.762590683352;5304.496072873225;5337.412884582615;5357.142857142839;5414;5475.041867673221 20:55:44 INFO - PID 3506 | |4;prototype.html;368.9114612493001;380.4388526922788;395.73881238382666;395.97030222733287;401.27770013974845;5618.83143505695;5619.915701264479;5651.208830763686;5664.631798933066;5670.270567476918;5509.3664228613725;5510.834674959758;5515.676237702953;5531.695756733378;5549.639273447223;4275.337322714976;4288.807003684826;4313.792138201308;4330.06903515744;4331.112122014979;4307.1601037797645;4308.095299987007;4312.05134870328;4318.740875547477;4329.848455304065;4286.521150203175;4306.095719898809;4310.504292006428;4322.827086916535;4344.847930322439;4243.427137336451;4270.743755374657;4307.310830267143;4319.43847299849;4333.913321733579;3870.554886188096;3882.456456096149;3889.669378102865;3892.0464486201063;3900.4539364488996;5413.810516631938;5422.620416570841;5435.945640543583;5462.481064298885;5463.453654634544;5023.266972894346;5080.59355251579;5098.643094983353;5115.181570948667;5131.563817075553;5835.620684655484;5842.123681447774;5854.882902341972;5862.618929769594;5865.88268234633;4355.542668019875;4361.127774445092;4362.650987920959;4370.2789039808395;4377.1683380157665;5953.13679516472;6062.818115456499;6097.420745029215;6102.9694851525455;6109.1447197392845;4468.888277793016;4483.461984561874;4502.054568540643;4503.81984720614;4519;4522.095580883836;4570.771461426982;4575.496695363508;4585.423369771584;4600.677952543357;5006.098902197639;5058.797648094035;5072.771725272298;5079.111155547765;5091.490850914953;5855.824325270249;5859.53123750099;5860.267466566679;5873.735681894325;5897.351291357947;1557.672888693387;1579.1867188397985;1581.5650696058676;1597.9520614381588;1598.5923589484607;1092.530212008828;1116.748731535398;1119.6864877834219;1123.101518784985;1126.3298337489182;5137.922931156036;5144.43411224765;5147.510986456281;5150.381954165449;5162.457941916045;6059.27288725347;6065.363136870565;6077.4834139098675;6087.29996050451;6091.451769340692;4932.210846264652;5119.539241468211;5131.384233891882;5145.382554093533;5167.948320516747;3212.823294718813;3227.661095584977;3228.8224147672104;3235.3044095519576;3236.2556611979376;5470.152126420411;5628.480310316274;5673.269652755866;5678.346990096109;5693.259876216148;6079.969600151971;6223.253209614875;6243.687815609202;6263.091851681572;6290.528210384239;5638.35158956717;5662.8301150965535;5669.518090962232;5672.517835983987;5690.240233486756;6029.728662210299;6089.421504957199;6094.603850749687;6105.9084113737445;6114.872461088837;5974.193483879794;5978.282606087123;6011.849703757441;6023.096535519532;6025.096235564701;5667.093265077568;5670.744816483186;5685.459881311269;5690.857728556819;5699.800506982236;4112.629863312316;4136.958630413777;4137.275976704125;4167.5832416758085;4170.2910505214795;6024.3674414187635;6090.9390906090375;6116.17431646722;6132.969335153296;6146.446819786241;5881.441263080001;5886.705664716661;5888.823335299948;5920.615160014585;5922.2597175353085;5726.799562015476;5831.912521312099;5858.736356864037;5879.529637628894;5886.175935369138;5772.19189313488;5811.157382179645;5815.389384114607;5822.864541414384;5826.7086645666695;5729.19269557922;5829.271341082364;5864.501517371071;5866.325372582208;5882.294124705063;5771.903338365697;5773.24947756789;5776.797812076557;5782.2194003808945;5783.479486846204 20:55:44 INFO - PID 3506 | |5;yui.html;686.9622170780607;707.5507053021331;710.2790667472514;713.7252157919199;735.4337160386499;12662.43019064142;13326.800097998537;13676.589702308935;14477.5656730298;14648.926755366221;15055;15096.849031509682;15562.53312400627;15765.448209312677;15845.207739613032;894.7852515396307;909.6997990663066;914.9313801464883;916.5875356089753;917.6925729880498;881.1364862434817;911.3028533172129;928.1878356438117;928.2481190235897;928.8281667891428;972.0231167676475;982.778874753182;983.1151963233076;983.6901376066517;984.3798407003578;968.3850754770701;970;974.4056125763278;974.6052848596295;977.3500622086304;704.4646068987555;707.9362857342812;709.7906117695293;710.6091649592755;710.9253528379497;14507.274636268145;14695.412183512646;14700.411983520646;14732.70534589313;15154.469593564172;15802.288896999662;15863.20683965797;16147.434839780668;16164.353425862952;16179.191040448048;11741.412929353499;11966.82049769254;12011.21927074746;12036;12129.332886691229;2954.0399370204555;2963.4221326841275;2978.4638765022287;2980;2984.2390190501283;68519.31480685229;69405.15983122673;70664.6466767668;71825.6408717953;72363;12232.633021009384;12347.6913077172;12390.876091239152;12466;12565.308908009963;22698.773012269667;22708;22710.659340109913;22957.540849182922;23243.767562324498;6332.208473940757;6510.21877374718;6567.179102612174;6588.8023359299295;6597.208334999831;3073.139520934142;3116.6104236970377;3140.2463408782187;3144.591203143577;3150.039238032422;3368.814715190639;3397.2016576104597;3402.5236466894653;3449.3963556377535;3501.509788629594;679.100192245277;681.1689738518999;683.2108914204102;684.8459096703202;686.704716971707;592.1236569876521;608.6500262349167;609.2232403685248;611.6116266170925;627.5418944170781;9402.764930876783;10479.738006549745;10509.527071281811;10945.069669078217;10995.670129895956;587.5593305021234;597.9491743201789;602.3795490644643;611.7063809371526;617.7868635320807;4675.812967481331;4688.671792974459;4786.95213047872;4863.8540843774035;4928.852134435972;59299;60532.69733651303;61304.69347653233;63559.682201588694;64903.67548162229;50763.492365076614;55557.72221138949;56610;56693;57243.14135287974;48124.75937620289;48425.75787121112;48666.27000594994;48897;49684.751576241884;10590.046895779416;11166.330020198815;11177.608783692533;11251.156163287622;11452.656420307405;25944.351391215372;26221.606675899497;26576;26586;26666;30805.537916930814;31075.533866992464;31191.84404077965;31762.20594485064;31987;13796.931015344859;13940.790888136484;13958.720825583634;13978.860211398163;14122.717545649235;16081.195940203177;16307.510774676779;16319.265633046303;16413.753793692864;16464.917675411547;14440;14778.63053423673;15307.77038344448;15405;15510.379584816481;14415.78376324377;14444.205568693402;15084.849151508344;15489.070655760239;15645;13055.738885222052;13266.53567125146;14281;14945.850541494447;14974.251287435802;9561.330706850731;9762.804743905224;10016.699499015042;10040.297179197678;10057.647982320876;11541.538338466367;12137.635870923887;12182.695432614255;12222.694432639255;12430.067744918986 20:55:44 INFO - PID 3506 | __end_tp_report 20:55:44 INFO - PID 3506 | __start_cc_report 20:55:44 INFO - PID 3506 | _x_x_mozilla_cycle_collect,351 20:55:44 INFO - PID 3506 | __end_cc_report 20:55:44 INFO - PID 3506 | __startTimestamp1494215744276__endTimestamp 20:55:44 INFO - PID 3506 | 20:55:44 INFO - PID 3506 | ------- Summary: start ------- 20:55:44 INFO - PID 3506 | Number of tests: 6 20:55:44 INFO - PID 3506 | 20:55:44 INFO - PID 3506 | [#0] dojo.html Cycles:165 Average:5203.89 Median:5397.19 stddev:608.30 (11.3%) stddev-sans-first:578.61 20:55:44 INFO - PID 3506 | Values: 2738.6 2750.8 2768.5 2785.5 2790.9 5240.5 5315.4 5326.4 5333.2 5397.2 5275.9 5295.6 5322.3 5364.2 5398.3 4701.5 4704.8 4717.1 4731.8 4786.3 4766.6 4773.1 4800.6 4815.1 4819.3 4600.7 4667.1 4674.6 4676.8 4729.1 4680.3 4696.2 4698.1 4699.9 4721.3 4656.4 4656.7 4660.4 4672.2 4679.9 5208.8 5239.6 5241.7 5272.3 5278.7 5675.0 5699.3 5700.9 5702.9 5718.2 5708.0 5742.3 5772.9 5837.2 5843.4 5208.9 5214.7 5219.9 5269.2 5274.7 5700.9 5755.1 5761.3 5761.5 5785.6 5519.4 5561.5 5621.4 5644.2 5741.4 5558.8 5662.7 5665.8 5718.2 5745.1 5597.6 5622.0 5627.9 5651.6 5665.9 5580.6 5614.9 5636.1 5639.5 5694.5 4706.5 4707.1 4707.7 4711.3 4711.4 4081.8 4088.8 4099.5 4110.3 4111.3 4711.0 4778.7 4812.9 4830.4 4838.3 4966.9 5634.5 5677.2 5745.9 5749.9 4868.6 4876.1 4876.3 4886.0 4903.8 5056.7 5067.7 5073.2 5075.8 5076.6 5243.9 5326.7 5329.5 5418.8 5420.5 5753.0 5822.1 5822.9 5825.8 5867.2 5316.5 5366.8 5372.3 5374.9 5392.5 5551.8 5647.9 5651.9 5656.5 5687.1 5660.0 5665.1 5665.3 5716.3 5728.2 5479.2 5480.9 5482.3 5482.3 5486.8 5450.9 5475.4 5486.9 5505.9 5519.5 5438.1 5464.2 5485.8 5488.3 5489.8 5503.0 5541.4 5548.4 5553.9 5563.1 5472.4 5514.8 5542.4 5549.9 5560.4 20:55:44 INFO - PID 3506 | 20:55:44 INFO - PID 3506 | [#1] ext.html Cycles:180 Average:31146.88 Median:3175.78 stddev:41533.36 (1307.8%) stddev-sans-first:41587.03 20:55:44 INFO - PID 3506 | Values: 719.5 738.2 1019.6 1057.6 1116.2 31255.4 33951.3 34191.7 34405.5 34415.3 31850.7 32122.2 32182.8 32190.4 32240.2 6332.7 6405.1 6434.6 6530.4 6533.4 7067.6 7165.6 7173.4 7176.7 7183.3 7150.4 7184.8 7196.1 7197.7 7211.5 7143.0 7150.2 7160.3 7166.7 7204.2 6967.1 6980.0 6997.4 7043.6 7062.1 32364.8 32692.5 32713.2 32749.3 32818.0 3089.4 3106.6 3135.5 3143.7 3146.5 25066.0 25129.4 25138.7 25275.1 25373.9 3124.3 3136.3 3175.0 3176.6 3188.9 150731.2 151470.0 151561.0 152097.0 152634.0 40045.8 42179.6 42992.4 43256.4 43345.3 43241.0 43909.6 43989.6 44178.8 44184.6 13000.7 13097.5 13118.1 13128.5 13129.1 9578.2 9861.1 9938.0 10323.3 10338.1 12990.2 12995.3 13188.0 13210.5 13388.1 5403.7 5589.6 5616.1 5631.6 5690.0 876.2 910.9 919.1 922.1 944.1 21556.4 22637.9 22698.2 22701.2 22999.8 979.5 981.9 985.1 1007.9 1013.2 11510.7 11845.0 11883.7 11928.1 11947.2 176150.0 177265.0 178497.0 178655.1 178702.0 42439.4 42588.8 42967.6 42974.6 43021.4 1214.6 1230.3 1239.9 1244.3 1250.3 20854.3 20892.6 21966.0 22058.6 22059.0 31034.7 31075.2 31078.0 31171.2 31361.5 142736.3 153885.0 154400.2 154830.0 154847.0 32776.2 32994.3 33019.5 33081.3 33472.8 36260.0 37546.0 39684.6 39809.8 39811.6 27266.7 27730.3 28008.6 28038.9 28549.0 28644.7 28721.9 28885.9 29970.9 30069.4 32624.7 32778.3 32814.0 32846.5 33028.5 26888.9 27884.8 28005.9 28019.3 29665.6 21473.6 23182.3 23258.8 23267.4 23369.9 20:55:44 INFO - PID 3506 | 20:55:44 INFO - PID 3506 | [#2] jquery.html Cycles:180 Average:24264.50 Median:339079.50 stddev:56279.82 (16.6%) stddev-sans-first:56409.24 20:55:44 INFO - PID 3506 | Values: 424.5 425.1 432.1 444.0 452.5 16754.8 17328.3 17794.7 17915.4 18256.4 18498.2 18598.2 18759.8 18928.9 19267.2 5414.8 5446.2 5561.1 5598.7 5618.1 5463.8 5505.8 5528.3 5528.6 5529.4 5339.3 5366.9 5393.0 5396.2 5406.3 5426.1 5453.8 5464.5 5468.1 5492.4 4840.2 4972.6 4975.7 4981.2 5003.7 21854.2 21895.5 21897.8 21913.0 21940.1 1608.0 1680.8 1692.8 1693.5 1694.6 14959.4 15026.4 15135.2 15283.5 15417.2 2086.3 2140.9 2150.4 2164.4 2187.5 81031.0 86861.6 90702.5 97310.0 99627.5 11262.3 11438.8 11546.3 11638.8 11643.0 16176.2 16184.2 16208.2 16236.4 16265.3 7210.9 7429.6 7439.1 7616.5 7647.9 6689.0 6693.6 6882.3 6909.2 6922.2 6949.2 7137.5 7150.6 7205.4 7207.7 1942.3 1976.4 1989.7 2002.9 2192.2 851.3 893.1 893.6 899.2 917.2 17537.9 17566.8 18190.9 18291.3 18563.8 893.4 894.4 900.1 902.4 924.1 9719.2 9829.5 10113.2 10214.2 10294.1 331916.0 333119.0 333898.0 339053.0 339106.0 73768.0 74623.0 76265.2 76567.0 81131.6 1091.8 1116.6 1128.9 1139.7 1144.9 17558.3 17667.9 18215.0 18458.3 18673.2 38013.4 38269.0 38424.0 38609.0 39232.2 51398.0 51593.0 51909.5 52386.5 54317.0 8236.6 8445.7 8510.7 8636.5 8669.7 12608.8 12723.4 12946.5 13084.2 13561.8 10884.1 10988.2 11144.8 11312.8 11583.6 9946.8 10788.1 10808.0 10840.9 10949.5 11368.9 11420.4 11519.8 11604.3 11833.9 8554.3 8639.1 8825.9 8830.7 8842.6 11143.8 11171.6 11189.3 11190.2 11520.0 20:55:44 INFO - PID 3506 | 20:55:44 INFO - PID 3506 | [#3] mootools.html Cycles:180 Average:6127.58 Median:5064.08 stddev:3772.71 (74.5%) stddev-sans-first:3765.22 20:55:44 INFO - PID 3506 | Values: 1213.3 1267.7 1275.7 1280.4 1290.7 9295.7 9629.6 9680.8 9684.1 9953.8 9708.8 9858.2 9872.6 9874.3 9886.4 2214.6 2233.0 2238.4 2245.6 2247.1 2180.1 2207.4 2227.9 2240.4 2245.8 2208.6 2221.7 2241.0 2251.4 2258.6 2114.7 2138.5 2175.0 2176.4 2183.8 2072.7 2183.4 2191.7 2221.9 2225.9 9710.3 9735.6 9751.7 9775.8 9777.2 5316.3 5501.1 5531.3 5533.9 5552.1 3133.3 3344.9 3407.2 3410.7 3410.8 1103.7 1107.3 1124.6 1132.0 1144.2 13849.1 13885.4 13897.0 13966.6 13974.6 4690.5 4739.5 4831.1 4911.0 4957.5 10212.8 10232.7 10236.2 10259.0 10262.2 5536.9 5565.0 5566.4 5574.1 5582.8 5040.4 5190.1 5207.7 5223.2 5287.9 3723.6 3823.4 3902.0 4002.3 4087.7 1120.8 1141.7 1161.0 1164.4 1168.8 683.5 690.5 699.2 717.4 719.1 5374.1 6256.7 6403.4 6410.3 6435.8 835.3 840.8 847.8 869.7 871.3 3515.8 3549.7 3551.2 4202.5 4588.5 12094.8 12624.9 12647.9 12703.4 12704.7 12253.8 12571.1 12601.3 12666.4 12777.9 7012.1 7436.3 7647.8 7648.5 7660.6 6042.7 6335.3 6341.6 6412.6 6547.3 11049.7 11318.9 11564.7 11565.7 11576.3 11074.4 11276.7 11318.1 11452.5 11498.7 8019.8 8146.2 8180.3 8210.3 8214.9 9108.5 9428.5 9515.5 9532.9 9546.6 7948.6 7949.9 7965.8 8012.2 8136.8 7528.9 7645.8 7783.9 7923.8 7961.0 6945.7 7080.7 7112.4 7128.1 7173.7 5087.8 5161.2 5203.9 5260.5 5275.8 5304.5 5337.4 5357.1 5414.0 5475.0 20:55:44 INFO - PID 3506 | 20:55:44 INFO - PID 3506 | [#4] prototype.html Cycles:180 Average:4900.82 Median:5489.76 stddev:1397.80 (25.5%) stddev-sans-first:1359.70 20:55:44 INFO - PID 3506 | Values: 368.9 380.4 395.7 396.0 401.3 5618.8 5619.9 5651.2 5664.6 5670.3 5509.4 5510.8 5515.7 5531.7 5549.6 4275.3 4288.8 4313.8 4330.1 4331.1 4307.2 4308.1 4312.1 4318.7 4329.8 4286.5 4306.1 4310.5 4322.8 4344.8 4243.4 4270.7 4307.3 4319.4 4333.9 3870.6 3882.5 3889.7 3892.0 3900.5 5413.8 5422.6 5435.9 5462.5 5463.5 5023.3 5080.6 5098.6 5115.2 5131.6 5835.6 5842.1 5854.9 5862.6 5865.9 4355.5 4361.1 4362.7 4370.3 4377.2 5953.1 6062.8 6097.4 6103.0 6109.1 4468.9 4483.5 4502.1 4503.8 4519.0 4522.1 4570.8 4575.5 4585.4 4600.7 5006.1 5058.8 5072.8 5079.1 5091.5 5855.8 5859.5 5860.3 5873.7 5897.4 1557.7 1579.2 1581.6 1598.0 1598.6 1092.5 1116.7 1119.7 1123.1 1126.3 5137.9 5144.4 5147.5 5150.4 5162.5 6059.3 6065.4 6077.5 6087.3 6091.5 4932.2 5119.5 5131.4 5145.4 5167.9 3212.8 3227.7 3228.8 3235.3 3236.3 5470.2 5628.5 5673.3 5678.3 5693.3 6080.0 6223.3 6243.7 6263.1 6290.5 5638.4 5662.8 5669.5 5672.5 5690.2 6029.7 6089.4 6094.6 6105.9 6114.9 5974.2 5978.3 6011.8 6023.1 6025.1 5667.1 5670.7 5685.5 5690.9 5699.8 4112.6 4137.0 4137.3 4167.6 4170.3 6024.4 6090.9 6116.2 6133.0 6146.4 5881.4 5886.7 5888.8 5920.6 5922.3 5726.8 5831.9 5858.7 5879.5 5886.2 5772.2 5811.2 5815.4 5822.9 5826.7 5729.2 5829.3 5864.5 5866.3 5882.3 5771.9 5773.2 5776.8 5782.2 5783.5 20:55:44 INFO - PID 3506 | 20:55:44 INFO - PID 3506 | [#5] yui.html Cycles:180 Average:15211.71 Median:17154.23 stddev:17558.14 (102.4%) stddev-sans-first:17573.51 20:55:44 INFO - PID 3506 | Values: 687.0 707.6 710.3 713.7 735.4 12662.4 13326.8 13676.6 14477.6 14648.9 15055.0 15096.8 15562.5 15765.4 15845.2 894.8 909.7 914.9 916.6 917.7 881.1 911.3 928.2 928.2 928.8 972.0 982.8 983.1 983.7 984.4 968.4 970.0 974.4 974.6 977.4 704.5 707.9 709.8 710.6 710.9 14507.3 14695.4 14700.4 14732.7 15154.5 15802.3 15863.2 16147.4 16164.4 16179.2 11741.4 11966.8 12011.2 12036.0 12129.3 2954.0 2963.4 2978.5 2980.0 2984.2 68519.3 69405.2 70664.6 71825.6 72363.0 12232.6 12347.7 12390.9 12466.0 12565.3 22698.8 22708.0 22710.7 22957.5 23243.8 6332.2 6510.2 6567.2 6588.8 6597.2 3073.1 3116.6 3140.2 3144.6 3150.0 3368.8 3397.2 3402.5 3449.4 3501.5 679.1 681.2 683.2 684.8 686.7 592.1 608.7 609.2 611.6 627.5 9402.8 10479.7 10509.5 10945.1 10995.7 587.6 597.9 602.4 611.7 617.8 4675.8 4688.7 4787.0 4863.9 4928.9 59299.0 60532.7 61304.7 63559.7 64903.7 50763.5 55557.7 56610.0 56693.0 57243.1 48124.8 48425.8 48666.3 48897.0 49684.8 10590.0 11166.3 11177.6 11251.2 11452.7 25944.4 26221.6 26576.0 26586.0 26666.0 30805.5 31075.5 31191.8 31762.2 31987.0 13796.9 13940.8 13958.7 13978.9 14122.7 16081.2 16307.5 16319.3 16413.8 16464.9 14440.0 14778.6 15307.8 15405.0 15510.4 14415.8 14444.2 15084.8 15489.1 15645.0 13055.7 13266.5 14281.0 14945.9 14974.3 9561.3 9762.8 10016.7 10040.3 10057.6 11541.5 12137.6 12182.7 12222.7 12430.1 20:55:44 INFO - PID 3506 | -------- Summary: end -------- 20:55:44 INFO - PID 3506 | 20:55:45 INFO - TEST-INFO | 3506: exit 0 20:55:45 INFO - TEST-OK | dromaeo_css | took 1120768ms 20:55:45 INFO - TEST-START | kraken 20:55:45 INFO - operating with platform_type : linux_ 20:55:45 INFO - Initialising browser for kraken test... 20:55:45 INFO - TEST-INFO | started process 3923 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnAAcdd/profile http://localhost:36701/getInfo.html) 20:55:48 INFO - PID 3923 | __metrics Screen width/height:1600/1200 20:55:48 INFO - PID 3923 | colorDepth:24 20:55:48 INFO - PID 3923 | Browser inner width/height: 1024/695 20:55:48 INFO - PID 3923 | __metrics 20:55:51 INFO - TEST-INFO | 3923: exit 0 20:55:51 INFO - Browser initialized. 20:55:51 INFO - Running cycle 1/1 for kraken test... 20:55:51 INFO - TEST-INFO | started process 4093 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnAAcdd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:56:03 INFO - PID 4093 | RSS: Main: 159748096 20:56:03 INFO - PID 4093 | 20:56:05 INFO - PID 4093 | Cycle 1(1): loaded http://localhost:36701/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36701/tests/kraken/driver.html?testName=audio-beat-detection) 20:56:06 INFO - PID 4093 | RSS: Main: 166051840 20:56:06 INFO - PID 4093 | 20:56:09 INFO - PID 4093 | Cycle 1(1): loaded http://localhost:36701/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36701/tests/kraken/driver.html?testName=audio-dft) 20:56:09 INFO - PID 4093 | RSS: Main: 164409344 20:56:09 INFO - PID 4093 | 20:56:12 INFO - PID 4093 | Cycle 1(1): loaded http://localhost:36701/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36701/tests/kraken/driver.html?testName=audio-fft) 20:56:13 INFO - PID 4093 | RSS: Main: 160960512 20:56:13 INFO - PID 4093 | 20:56:15 INFO - PID 4093 | Cycle 1(1): loaded http://localhost:36701/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36701/tests/kraken/driver.html?testName=audio-oscillator) 20:56:16 INFO - PID 4093 | RSS: Main: 161652736 20:56:16 INFO - PID 4093 | 20:56:18 INFO - PID 4093 | Cycle 1(1): loaded http://localhost:36701/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36701/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:56:18 INFO - PID 4093 | RSS: Main: 161669120 20:56:18 INFO - PID 4093 | 20:56:22 INFO - PID 4093 | Cycle 1(1): loaded http://localhost:36701/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36701/tests/kraken/driver.html?testName=imaging-darkroom) 20:56:22 INFO - PID 4093 | RSS: Main: 167583744 20:56:22 INFO - PID 4093 | 20:56:26 INFO - PID 4093 | Cycle 1(1): loaded http://localhost:36701/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36701/tests/kraken/driver.html?testName=imaging-desaturate) 20:56:26 INFO - PID 4093 | RSS: Main: 165244928 20:56:26 INFO - PID 4093 | 20:56:29 INFO - PID 4093 | Cycle 1(1): loaded http://localhost:36701/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36701/tests/kraken/driver.html?testName=json-parse-financial) 20:56:30 INFO - PID 4093 | RSS: Main: 166109184 20:56:30 INFO - PID 4093 | 20:56:32 INFO - PID 4093 | Cycle 1(1): loaded http://localhost:36701/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36701/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:56:32 INFO - PID 4093 | RSS: Main: 166871040 20:56:32 INFO - PID 4093 | 20:56:34 INFO - PID 4093 | Cycle 1(1): loaded http://localhost:36701/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36701/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:56:35 INFO - PID 4093 | RSS: Main: 166682624 20:56:35 INFO - PID 4093 | 20:56:37 INFO - PID 4093 | Cycle 1(1): loaded http://localhost:36701/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36701/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:56:37 INFO - PID 4093 | RSS: Main: 166793216 20:56:37 INFO - PID 4093 | 20:56:40 INFO - PID 4093 | Cycle 1(1): loaded http://localhost:36701/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36701/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:56:41 INFO - PID 4093 | RSS: Main: 167084032 20:56:41 INFO - PID 4093 | 20:56:44 INFO - PID 4093 | Cycle 1(1): loaded http://localhost:36701/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36701/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:56:45 INFO - PID 4093 | RSS: Main: 166866944 20:56:45 INFO - PID 4093 | 20:56:46 INFO - PID 4093 | Cycle 1(1): loaded http://localhost:36701/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36701/tests/kraken/driver.html?testName=ai-astar) 20:56:47 INFO - PID 4093 | RSS: Main: 168271872 20:56:47 INFO - PID 4093 | 20:56:47 INFO - PID 4093 | __start_tp_report 20:56:47 INFO - PID 4093 | _x_x_mozilla_page_load 20:56:47 INFO - PID 4093 | _x_x_mozilla_page_load_details 20:56:47 INFO - PID 4093 | |i|pagename|runs| 20:56:47 INFO - PID 4093 | |0;ai-astar;104;112;112;111;110;112;110;112;111;111 20:56:47 INFO - PID 4093 | |1;audio-beat-detection;151;124;122;168;124;124;121;122;146;123 20:56:47 INFO - PID 4093 | |2;audio-dft;163;166;164;167;170;167;172;164;163;163 20:56:47 INFO - PID 4093 | |3;audio-fft;75;75;74;104;75;75;74;75;94;76 20:56:47 INFO - PID 4093 | |4;audio-oscillator;83;82;103;83;83;84;96;83;83;116 20:56:47 INFO - PID 4093 | |5;imaging-gaussian-blur;114;114;114;114;116;114;115;114;114;113 20:56:47 INFO - PID 4093 | |6;imaging-darkroom;151;153;151;151;151;150;151;150;151;150 20:56:47 INFO - PID 4093 | |7;imaging-desaturate;95;95;95;95;94;95;94;95;94;95 20:56:47 INFO - PID 4093 | |8;json-parse-financial;54;54;52;53;54;55;56;55;56;54 20:56:47 INFO - PID 4093 | |9;json-stringify-tinderbox;58;56;55;55;55;55;56;55;55;55 20:56:47 INFO - PID 4093 | |10;stanford-crypto-aes;83;82;81;83;85;83;82;83;82;83 20:56:47 INFO - PID 4093 | |11;stanford-crypto-ccm;133;130;132;142;131;144;130;129;183;140 20:56:47 INFO - PID 4093 | |12;stanford-crypto-pbkdf2;183;189;194;200;186;191;194;184;179;188 20:56:47 INFO - PID 4093 | |13;stanford-crypto-sha256-iterative;74;73;72;78;75;71;71;71;70;70 20:56:47 INFO - PID 4093 | __end_tp_report 20:56:47 INFO - PID 4093 | __start_cc_report 20:56:47 INFO - PID 4093 | _x_x_mozilla_cycle_collect,819 20:56:47 INFO - PID 4093 | __end_cc_report 20:56:47 INFO - PID 4093 | __startTimestamp1494215807048__endTimestamp 20:56:47 INFO - PID 4093 | 20:56:47 INFO - PID 4093 | ------- Summary: start ------- 20:56:47 INFO - PID 4093 | Number of tests: 14 20:56:47 INFO - PID 4093 | 20:56:47 INFO - PID 4093 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:2.42 (2.2%) stddev-sans-first:0.83 20:56:47 INFO - PID 4093 | Values: 104.0 112.0 112.0 111.0 110.0 112.0 110.0 112.0 111.0 111.0 20:56:47 INFO - PID 4093 | 20:56:47 INFO - PID 4093 | [#1] audio-beat-detection Cycles:10 Average:132.50 Median:124.00 stddev:16.48 (13.3%) stddev-sans-first:16.06 20:56:47 INFO - PID 4093 | Values: 151.0 124.0 122.0 168.0 124.0 124.0 121.0 122.0 146.0 123.0 20:56:47 INFO - PID 4093 | 20:56:47 INFO - PID 4093 | [#2] audio-dft Cycles:10 Average:165.90 Median:166.50 stddev:3.14 (1.9%) stddev-sans-first:3.15 20:56:47 INFO - PID 4093 | Values: 163.0 166.0 164.0 167.0 170.0 167.0 172.0 164.0 163.0 163.0 20:56:47 INFO - PID 4093 | 20:56:47 INFO - PID 4093 | [#3] audio-fft Cycles:10 Average:79.70 Median:75.00 stddev:10.46 (13.9%) stddev-sans-first:10.95 20:56:47 INFO - PID 4093 | Values: 75.0 75.0 74.0 104.0 75.0 75.0 74.0 75.0 94.0 76.0 20:56:47 INFO - PID 4093 | 20:56:47 INFO - PID 4093 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:83.00 stddev:11.66 (14.1%) stddev-sans-first:12.12 20:56:47 INFO - PID 4093 | Values: 83.0 82.0 103.0 83.0 83.0 84.0 96.0 83.0 83.0 116.0 20:56:47 INFO - PID 4093 | 20:56:47 INFO - PID 4093 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 20:56:47 INFO - PID 4093 | Values: 114.0 114.0 114.0 114.0 116.0 114.0 115.0 114.0 114.0 113.0 20:56:47 INFO - PID 4093 | 20:56:47 INFO - PID 4093 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 20:56:47 INFO - PID 4093 | Values: 151.0 153.0 151.0 151.0 151.0 150.0 151.0 150.0 151.0 150.0 20:56:47 INFO - PID 4093 | 20:56:47 INFO - PID 4093 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 20:56:47 INFO - PID 4093 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 95.0 20:56:47 INFO - PID 4093 | 20:56:47 INFO - PID 4093 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:1.25 (2.3%) stddev-sans-first:1.32 20:56:47 INFO - PID 4093 | Values: 54.0 54.0 52.0 53.0 54.0 55.0 56.0 55.0 56.0 54.0 20:56:47 INFO - PID 4093 | 20:56:47 INFO - PID 4093 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:0.44 20:56:47 INFO - PID 4093 | Values: 58.0 56.0 55.0 55.0 55.0 55.0 56.0 55.0 55.0 55.0 20:56:47 INFO - PID 4093 | 20:56:47 INFO - PID 4093 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:1.06 (1.3%) stddev-sans-first:1.12 20:56:47 INFO - PID 4093 | Values: 83.0 82.0 81.0 83.0 85.0 83.0 82.0 83.0 82.0 83.0 20:56:47 INFO - PID 4093 | 20:56:47 INFO - PID 4093 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:136.50 stddev:16.26 (11.9%) stddev-sans-first:17.08 20:56:47 INFO - PID 4093 | Values: 133.0 130.0 132.0 142.0 131.0 144.0 130.0 129.0 183.0 140.0 20:56:47 INFO - PID 4093 | 20:56:47 INFO - PID 4093 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.80 Median:190.00 stddev:6.20 (3.3%) stddev-sans-first:6.21 20:56:47 INFO - PID 4093 | Values: 183.0 189.0 194.0 200.0 186.0 191.0 194.0 184.0 179.0 188.0 20:56:47 INFO - PID 4093 | 20:56:47 INFO - PID 4093 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:72.50 stddev:2.55 (3.5%) stddev-sans-first:2.65 20:56:47 INFO - PID 4093 | Values: 74.0 73.0 72.0 78.0 75.0 71.0 71.0 71.0 70.0 70.0 20:56:47 INFO - PID 4093 | -------- Summary: end -------- 20:56:47 INFO - PID 4093 | 20:56:48 INFO - TEST-INFO | 4093: exit 0 20:56:48 INFO - TEST-OK | kraken | took 63339ms 20:56:48 INFO - SUITE-END | took 1184s 20:56:48 INFO - Completed test suite (00:19:44) 20:56:48 INFO - javascript benchmark 20:56:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6821.3450687445475, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2738.630284911537, 2750.7799376049916, 2768.515509785787, 2785.4986102501553, 2790.916272511825, 5240.475952404758, 5315.388730296012, 5326.414094449618, 5333.200019996998, 5397.190421436781, 5275.894482110355, 5295.629305948585, 5322.308099947011, 5364.168553874146, 5398.2712333834925, 4701.48283688794, 4704.811807527695, 4717.056588682261, 4731.810727570893, 4786.258129989839, 4766.594839438651, 4773.140834649762, 4800.5679488846, 4815.0610630926985, 4819.277108433728, 4600.677952543323, 4667.066586682677, 4674.626029917598, 4676.766161691936, 4729.054189162147, 4680.321353403771, 4696.178168820477, 4698.130845793539, 4699.859004229878, 4721.315409265671, 4656.41794775653, 4656.743879086649, 4660.4174478190225, 4672.15901137795, 4679.88300292492, 5208.791648334062, 5239.607029472767, 5241.659292146036, 5272.261883336336, 5278.683279003272, 5674.9716251418895, 5699.2590963174935, 5700.914486282709, 5702.857428564277, 5718.199452076713, 5708.001099807517, 5742.253507044099, 5772.855678608026, 5837.241158649391, 5843.4448727371255, 5208.869778255536, 5214.713190774468, 5219.921701174486, 5269.235960785664, 5274.736263186825, 5700.914486282709, 5755.1367294906095, 5761.308642962787, 5761.48146666802, 5785.595008349375, 5519.365272993577, 5561.5272701820795, 5621.353544342372, 5644.238027866268, 5741.397153298927, 5558.833235002876, 5662.68855212959, 5665.801696940587, 5718.228039214653, 5745.13822926556, 5597.608167428241, 5621.98804215237, 5627.943720562824, 5651.632643878134, 5665.858353541112, 5580.609357345028, 5614.859628509238, 5636.070048441961, 5639.464250896158, 5694.5159661428415, 4706.505816889246, 4707.082118986833, 4707.670463067552, 4711.293306004127, 4711.363965864564, 4081.795910204478, 4088.7751173685137, 4099.487564054493, 4110.321796903478, 4111.280525907954, 4710.9764451177525, 4778.689385190021, 4812.927806082912, 4830.396200474941, 4838.250071238964, 4966.925496117561, 5634.492895639412, 5677.205191273225, 5745.913811292834, 5749.913751293734, 4868.561829435368, 4876.146674331978, 4876.341693871353, 4886.047220791983, 4903.803847846046, 5056.721880296619, 5067.746612669352, 5073.213651883964, 5075.771590278447, 5076.568491678248, 5243.868903277448, 5326.707031113326, 5329.493698098674, 5418.756155972912, 5420.4850539198715, 5753.0, 5822.0684690449325, 5822.912656310074, 5825.76696932118, 5867.178594996619, 5316.468353164652, 5366.7656439018465, 5372.301600791872, 5374.919376209438, 5392.541633961, 5551.833444996657, 5647.915281270702, 5651.915221271766, 5656.462636049569, 5687.118496633028, 5660.009498337857, 5665.12190610456, 5665.3201615806365, 5716.28546431696, 5728.198052272768, 5479.232907392889, 5480.862978425412, 5482.259894914295, 5482.342118945752, 5486.753096110764, 5450.945490545044, 5475.4250803665045, 5486.862828429321, 5505.944940550704, 5519.530839878495, 5438.129899216106, 5464.23500709893, 5485.75314110858, 5488.286522752017, 5489.780408783764, 5502.972485137709, 5541.445855414427, 5548.389677135431, 5553.888922221614, 5563.082091455027, 5472.425395333433, 5514.779408823762, 5542.418046105101, 5549.916751248654, 5560.36055853582], "value": 5160.211769510785, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.4855678190095, 738.2285511640337, 1019.6176433837311, 1057.5505410200662, 1116.1573012375654, 31255.374892502135, 33951.32097358054, 34191.658083419155, 34405.48391774125, 34415.31169376611, 31850.68149318506, 32122.196945076386, 32182.839085804597, 32190.35619287613, 32240.193995150134, 6332.68336583169, 6405.135306733578, 6434.581752186116, 6530.379613936669, 6533.444657204143, 7067.611281379522, 7165.570065796042, 7173.354398104169, 7176.677049532757, 7183.317584829433, 7150.356467917886, 7184.784456466315, 7196.1364636243725, 7197.712091516333, 7211.459140564452, 7142.964285178593, 7150.1777295611155, 7160.28397160285, 7166.713331466735, 7204.171520275183, 6967.059446974644, 6980.0, 6997.405220556258, 7043.612601306926, 7062.117235345582, 32364.83817580897, 32692.509612355832, 32713.182170445692, 32749.345013099606, 32818.0, 3089.3666798306294, 3106.565080888655, 3135.5139953307275, 3143.7170654640963, 3146.496560550301, 25066.0, 25129.371765705822, 25138.748612513824, 25275.11537096211, 25373.873130634413, 3124.297033167542, 3136.278655909131, 3174.984125079383, 3176.571162893003, 3188.85650145744, 150731.2463437676, 151470.0, 151561.0, 152097.0, 152634.0, 40045.79977100096, 42179.57820421756, 42992.35511467331, 43256.35115473271, 43345.34981975273, 43241.0, 43909.56090439055, 43989.560104399185, 44178.77910610491, 44184.558154418686, 13000.739985200244, 13097.541586044443, 13118.147320424141, 13128.474861005643, 13129.146605470614, 9578.185854202331, 9861.112499875046, 9937.950310248403, 10323.328983616191, 10338.0695737384, 12990.155639883378, 12995.28525931064, 13188.021796730376, 13210.471581136839, 13388.06283560161, 5403.729813509309, 5589.552835773128, 5616.129499927518, 5631.577631677641, 5690.032694441955, 876.1982785751094, 910.8633704944311, 919.0579655852804, 922.077922077922, 944.0889541592396, 21556.353309400743, 22637.88681056584, 22698.205562805222, 22701.20545780923, 22999.770002300098, 979.5396163803001, 981.8821741391079, 985.1380042462845, 1007.8689770329956, 1013.1995723378449, 11510.712232194095, 11845.0, 11883.702907427383, 11928.105392095627, 11947.223430476992, 176150.0, 177265.0, 178497.0, 178655.10672446556, 178702.0, 42439.36340954888, 42588.78705606514, 42967.57032429636, 42974.57025429768, 43021.35467967983, 1214.6052532926833, 1230.2864338683721, 1239.8822111899356, 1244.321844594698, 1250.2810883742068, 20854.270100546408, 20892.58214835725, 21966.0, 22058.558828823654, 22059.0, 31034.68965310318, 31075.22311942129, 31078.0, 31171.220719481287, 31361.529577055906, 142736.2863185719, 153885.0, 154400.22799885928, 154830.0, 154847.0, 32776.180595485304, 32994.34011319808, 33019.504707428925, 33081.33837323288, 33472.81589801275, 36260.0, 37546.0, 39684.60315396809, 39809.80095099622, 39811.60188398079, 27266.72733272642, 27730.306742331602, 28008.57987130154, 28038.859805700842, 28549.000784972428, 28644.713552864203, 28721.856390717912, 28885.85557072201, 29970.850145749133, 30069.398612028075, 32624.673753263112, 32778.344433111684, 32814.0, 32846.507302390004, 33028.50457243095, 26888.865555672095, 27884.76921846288, 28005.859970700018, 28019.299517512227, 29665.588457327685, 21473.57052858903, 23182.3045308641, 23258.76741232634, 23267.418314541595, 23369.883150584137], "value": 14942.285060009313, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.50148036313016, 425.11788039817384, 432.09907343189457, 443.97780110994455, 452.4864279043287, 16754.832451675495, 17328.306867725292, 17794.73307900381, 17915.372961946334, 18256.361027364044, 18498.167582458787, 18598.163082661278, 18759.812401875977, 18928.905355473238, 19267.229310827584, 5414.756335964891, 5446.15584584388, 5561.110222364423, 5598.720063996804, 5618.073017952033, 5463.808766693167, 5505.807296744615, 5528.308961379827, 5528.585356098289, 5529.447055294479, 5339.279197308352, 5366.892662146754, 5392.973035134819, 5396.1905714142995, 5406.270153529283, 5426.050441172819, 5453.754581043842, 5464.535514481274, 5468.0977638689565, 5492.395836457987, 4840.225563909793, 4972.6021918246815, 4975.651704380694, 4981.178105612606, 5003.674761140514, 21854.23510177152, 21895.452613684785, 21897.781022189734, 21913.0, 21940.122395104176, 1607.9678406431922, 1680.7646929429889, 1692.7884014498188, 1693.542743459259, 1694.5594145522252, 14959.40162393503, 15026.398944042225, 15135.167565783877, 15283.465078722302, 15417.229138543027, 2086.3428020173596, 2140.914363425461, 2150.3656421355736, 2164.3723320237114, 2187.501561430425, 81031.0, 86861.56569217176, 90702.5464872678, 97310.0, 99627.50186249023, 11262.32426054423, 11438.828417573743, 11546.307221566733, 11638.825417618742, 11643.0, 16176.191190440431, 16184.19079046043, 16208.189590520427, 16236.350545978028, 16265.349386024664, 7210.927890721131, 7429.62851857405, 7439.144498382647, 7616.466847320745, 7647.891055796878, 6688.966555167193, 6693.564918280296, 6882.311768823178, 6909.239983601799, 6922.238553759083, 6949.166100068024, 7137.500374973806, 7150.606716630636, 7205.423566114699, 7207.747728829466, 1942.2716481319505, 1976.4465949534153, 1989.6816509358432, 2002.8698134621202, 2192.1669765489332, 851.2764150472173, 893.1381217125376, 893.5978809535735, 899.1817446123996, 917.2111983694018, 17537.94940745441, 17566.824331756517, 18190.90904545495, 18291.26834926588, 18563.81436185621, 893.3791015244343, 894.4096896048577, 900.0594378874092, 902.4089221559889, 924.089771574998, 9719.17387022111, 9829.508524573743, 10113.241506886865, 10214.233932455096, 10294.073533382032, 331916.0, 333119.0, 333898.0, 339053.0, 339106.0, 73768.0, 74623.0, 76265.23734762693, 76567.0, 81131.5943420279, 1091.8143915534379, 1116.5757012335262, 1128.8532490776147, 1139.720768411728, 1144.9255798373079, 17558.29766809313, 17667.911660441616, 18215.0, 18458.261669533604, 18673.15970781345, 38013.42979855249, 38269.0, 38424.03939901525, 38609.0, 39232.2153556933, 51398.0, 51593.0, 51909.48090519047, 52386.47613523816, 54317.0, 8236.588170591327, 8445.690917907734, 8510.744677659432, 8636.481811091355, 8669.739907802776, 12608.810867836806, 12723.427445764777, 12946.546870859474, 13084.214947103204, 13561.79657305161, 10884.12926965825, 10988.230823842254, 11144.777104457704, 11312.773744525228, 11583.594574189863, 9946.751331216778, 10788.136949043901, 10808.0, 10840.945795270973, 10949.45252737344, 11368.886311136783, 11420.428978550874, 11519.769604607693, 11604.30374177552, 11833.881661183623, 8554.315654747481, 8639.136086391562, 8825.867611985697, 8830.735077947671, 8842.557872106241, 11143.777124457627, 11171.608993685182, 11189.328640281608, 11190.160737944523, 11520.0], "value": 8993.059461615787, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1213.2780995307794, 1267.7020900088478, 1275.6747029507474, 1280.4302085571921, 1290.6515240884967, 9295.674651387195, 9629.566669499873, 9680.757981050469, 9684.080012398828, 9953.751156221098, 9708.805823883518, 9858.211343092553, 9872.60509579616, 9874.259430542703, 9886.357386769854, 2214.6013717530877, 2233.039792889057, 2238.3956331790405, 2245.6070187717164, 2247.1123906057096, 2180.1388451561625, 2207.4040009197506, 2227.922022729205, 2240.439890027493, 2245.78665026823, 2208.6355751301016, 2221.7333919929633, 2240.977590224093, 2251.448395143192, 2258.5934531784274, 2114.6722258050027, 2138.4546940530145, 2175.0321107107425, 2176.401489590375, 2183.8471307008517, 2072.6580114281123, 2183.366823621148, 2191.6822060801096, 2221.911123555056, 2225.899834507451, 9710.271729620306, 9735.610575576968, 9751.658691945819, 9775.804483910282, 9777.217822574177, 5316.308879845634, 5501.14732216507, 5531.2809334786625, 5533.889322213573, 5552.139418390156, 3133.310671652233, 3344.916377090568, 3407.1993081625797, 3410.693037626601, 3410.795352278871, 1103.7406209540752, 1107.2968664897849, 1124.5614210457927, 1131.9943400283028, 1144.1819099343925, 13849.099808512516, 13885.37515811791, 13897.0, 13966.58100256994, 13974.554452970791, 4690.525854644452, 4739.454962679267, 4831.057943700945, 4911.0423467424225, 4957.529034741694, 10212.846807297896, 10232.744181395525, 10236.181105511541, 10259.0, 10262.230332725076, 5536.916946245809, 5565.026120428909, 5566.359868615161, 5574.052411090043, 5582.8325150245555, 5040.395152581714, 5190.143626301618, 5207.661502002357, 5223.242629818655, 5287.894242115136, 3723.6090210528046, 3823.4264860271182, 3901.9804900975314, 4002.3196056670436, 4087.693422993228, 1120.8262719278525, 1141.6632093532428, 1161.0, 1164.441068287227, 1168.7545615420686, 683.4634811672813, 690.5304393012699, 699.2378307644692, 717.3507975282378, 719.1154879498247, 5374.113271310268, 6256.74973001084, 6403.391677790602, 6410.262819775786, 6435.843992262551, 835.3275613131366, 840.7561807076002, 847.7668641123616, 869.7129947117436, 871.3464901324007, 3515.82420878955, 3549.716022718176, 3551.2187318789825, 4202.495700515958, 4588.541145885385, 12094.758104837854, 12624.936875315565, 12647.936760316323, 12703.428345724464, 12704.745905081847, 12253.816192757116, 12571.1200215984, 12601.306928118858, 12666.430010649543, 12777.93611031939, 7012.0533727947095, 7436.293552112541, 7647.847043059108, 7648.464607477535, 7660.578668173192, 6042.667653278936, 6335.334789847, 6341.55609107358, 6412.647304398116, 6547.312532184243, 11049.668509944715, 11318.94340528292, 11564.653060408202, 11565.653030409101, 11576.305421674726, 11074.39090850011, 11276.718082048015, 11318.094552435621, 11452.484638191134, 11498.655040348804, 8019.759407217793, 8146.2261085196815, 8180.263776260165, 8210.302124319262, 8214.876776848472, 9108.499032553273, 9428.528573571157, 9515.524223788645, 9532.904670953201, 9546.570404331684, 7948.602569871599, 7949.92050079515, 7965.840683186188, 8012.238837310446, 8136.83726325482, 7528.924710753042, 7645.808854778675, 7783.92216077832, 7923.84152316962, 7961.044674639081, 6945.652717364213, 7080.681369338495, 7112.35988761014, 7128.108986376703, 7173.677184526605, 5087.771050302819, 5161.174212126042, 5203.869903252449, 5260.526552610283, 5275.762590683352, 5304.496072873225, 5337.412884582615, 5357.142857142839, 5414.0, 5475.041867673221], "value": 4692.704262862757, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.9114612493001, 380.4388526922788, 395.73881238382666, 395.97030222733287, 401.27770013974845, 5618.83143505695, 5619.915701264479, 5651.208830763686, 5664.631798933066, 5670.270567476918, 5509.3664228613725, 5510.834674959758, 5515.676237702953, 5531.695756733378, 5549.639273447223, 4275.337322714976, 4288.807003684826, 4313.792138201308, 4330.06903515744, 4331.112122014979, 4307.1601037797645, 4308.095299987007, 4312.05134870328, 4318.740875547477, 4329.848455304065, 4286.521150203175, 4306.095719898809, 4310.504292006428, 4322.827086916535, 4344.847930322439, 4243.427137336451, 4270.743755374657, 4307.310830267143, 4319.43847299849, 4333.913321733579, 3870.554886188096, 3882.456456096149, 3889.669378102865, 3892.0464486201063, 3900.4539364488996, 5413.810516631938, 5422.620416570841, 5435.945640543583, 5462.481064298885, 5463.453654634544, 5023.266972894346, 5080.59355251579, 5098.643094983353, 5115.181570948667, 5131.563817075553, 5835.620684655484, 5842.123681447774, 5854.882902341972, 5862.618929769594, 5865.88268234633, 4355.542668019875, 4361.127774445092, 4362.650987920959, 4370.2789039808395, 4377.1683380157665, 5953.13679516472, 6062.818115456499, 6097.420745029215, 6102.9694851525455, 6109.1447197392845, 4468.888277793016, 4483.461984561874, 4502.054568540643, 4503.81984720614, 4519.0, 4522.095580883836, 4570.771461426982, 4575.496695363508, 4585.423369771584, 4600.677952543357, 5006.098902197639, 5058.797648094035, 5072.771725272298, 5079.111155547765, 5091.490850914953, 5855.824325270249, 5859.53123750099, 5860.267466566679, 5873.735681894325, 5897.351291357947, 1557.672888693387, 1579.1867188397985, 1581.5650696058676, 1597.9520614381588, 1598.5923589484607, 1092.530212008828, 1116.748731535398, 1119.6864877834219, 1123.101518784985, 1126.3298337489182, 5137.922931156036, 5144.43411224765, 5147.510986456281, 5150.381954165449, 5162.457941916045, 6059.27288725347, 6065.363136870565, 6077.4834139098675, 6087.29996050451, 6091.451769340692, 4932.210846264652, 5119.539241468211, 5131.384233891882, 5145.382554093533, 5167.948320516747, 3212.823294718813, 3227.661095584977, 3228.8224147672104, 3235.3044095519576, 3236.2556611979376, 5470.152126420411, 5628.480310316274, 5673.269652755866, 5678.346990096109, 5693.259876216148, 6079.969600151971, 6223.253209614875, 6243.687815609202, 6263.091851681572, 6290.528210384239, 5638.35158956717, 5662.8301150965535, 5669.518090962232, 5672.517835983987, 5690.240233486756, 6029.728662210299, 6089.421504957199, 6094.603850749687, 6105.9084113737445, 6114.872461088837, 5974.193483879794, 5978.282606087123, 6011.849703757441, 6023.096535519532, 6025.096235564701, 5667.093265077568, 5670.744816483186, 5685.459881311269, 5690.857728556819, 5699.800506982236, 4112.629863312316, 4136.958630413777, 4137.275976704125, 4167.5832416758085, 4170.2910505214795, 6024.3674414187635, 6090.9390906090375, 6116.17431646722, 6132.969335153296, 6146.446819786241, 5881.441263080001, 5886.705664716661, 5888.823335299948, 5920.615160014585, 5922.2597175353085, 5726.799562015476, 5831.912521312099, 5858.736356864037, 5879.529637628894, 5886.175935369138, 5772.19189313488, 5811.157382179645, 5815.389384114607, 5822.864541414384, 5826.7086645666695, 5729.19269557922, 5829.271341082364, 5864.501517371071, 5866.325372582208, 5882.294124705063, 5771.903338365697, 5773.24947756789, 5776.797812076557, 5782.2194003808945, 5783.479486846204], "value": 4476.755455795247, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.9622170780607, 707.5507053021331, 710.2790667472514, 713.7252157919199, 735.4337160386499, 12662.43019064142, 13326.800097998537, 13676.589702308935, 14477.5656730298, 14648.926755366221, 15055.0, 15096.849031509682, 15562.53312400627, 15765.448209312677, 15845.207739613032, 894.7852515396307, 909.6997990663066, 914.9313801464883, 916.5875356089753, 917.6925729880498, 881.1364862434817, 911.3028533172129, 928.1878356438117, 928.2481190235897, 928.8281667891428, 972.0231167676475, 982.778874753182, 983.1151963233076, 983.6901376066517, 984.3798407003578, 968.3850754770701, 970.0, 974.4056125763278, 974.6052848596295, 977.3500622086304, 704.4646068987555, 707.9362857342812, 709.7906117695293, 710.6091649592755, 710.9253528379497, 14507.274636268145, 14695.412183512646, 14700.411983520646, 14732.70534589313, 15154.469593564172, 15802.288896999662, 15863.20683965797, 16147.434839780668, 16164.353425862952, 16179.191040448048, 11741.412929353499, 11966.82049769254, 12011.21927074746, 12036.0, 12129.332886691229, 2954.0399370204555, 2963.4221326841275, 2978.4638765022287, 2980.0, 2984.2390190501283, 68519.31480685229, 69405.15983122673, 70664.6466767668, 71825.6408717953, 72363.0, 12232.633021009384, 12347.6913077172, 12390.876091239152, 12466.0, 12565.308908009963, 22698.773012269667, 22708.0, 22710.659340109913, 22957.540849182922, 23243.767562324498, 6332.208473940757, 6510.21877374718, 6567.179102612174, 6588.8023359299295, 6597.208334999831, 3073.139520934142, 3116.6104236970377, 3140.2463408782187, 3144.591203143577, 3150.039238032422, 3368.814715190639, 3397.2016576104597, 3402.5236466894653, 3449.3963556377535, 3501.509788629594, 679.100192245277, 681.1689738518999, 683.2108914204102, 684.8459096703202, 686.704716971707, 592.1236569876521, 608.6500262349167, 609.2232403685248, 611.6116266170925, 627.5418944170781, 9402.764930876783, 10479.738006549745, 10509.527071281811, 10945.069669078217, 10995.670129895956, 587.5593305021234, 597.9491743201789, 602.3795490644643, 611.7063809371526, 617.7868635320807, 4675.812967481331, 4688.671792974459, 4786.95213047872, 4863.8540843774035, 4928.852134435972, 59299.0, 60532.69733651303, 61304.69347653233, 63559.682201588694, 64903.67548162229, 50763.492365076614, 55557.72221138949, 56610.0, 56693.0, 57243.14135287974, 48124.75937620289, 48425.75787121112, 48666.27000594994, 48897.0, 49684.751576241884, 10590.046895779416, 11166.330020198815, 11177.608783692533, 11251.156163287622, 11452.656420307405, 25944.351391215372, 26221.606675899497, 26576.0, 26586.0, 26666.0, 30805.537916930814, 31075.533866992464, 31191.84404077965, 31762.20594485064, 31987.0, 13796.931015344859, 13940.790888136484, 13958.720825583634, 13978.860211398163, 14122.717545649235, 16081.195940203177, 16307.510774676779, 16319.265633046303, 16413.753793692864, 16464.917675411547, 14440.0, 14778.63053423673, 15307.77038344448, 15405.0, 15510.379584816481, 14415.78376324377, 14444.205568693402, 15084.849151508344, 15489.070655760239, 15645.0, 13055.738885222052, 13266.53567125146, 14281.0, 14945.850541494447, 14974.251287435802, 9561.330706850731, 9762.804743905224, 10016.699499015042, 10040.297179197678, 10057.647982320876, 11541.538338466367, 12137.635870923887, 12182.695432614255, 12222.694432639255, 12430.067744918986], "value": 6915.278655633266, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 112.0, 111.0, 110.0, 112.0, 110.0, 112.0, 111.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 122.0, 168.0, 124.0, 124.0, 121.0, 122.0, 146.0, 123.0], "value": 132.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 164.0, 167.0, 170.0, 167.0, 172.0, 164.0, 163.0, 163.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 104.0, 75.0, 75.0, 74.0, 75.0, 94.0, 76.0], "value": 79.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 103.0, 83.0, 83.0, 84.0, 96.0, 83.0, 83.0, 116.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 116.0, 114.0, 115.0, 114.0, 114.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 153.0, 151.0, 151.0, 151.0, 150.0, 151.0, 150.0, 151.0, 150.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 52.0, 53.0, 54.0, 55.0, 56.0, 55.0, 56.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 55.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 81.0, 83.0, 85.0, 83.0, 82.0, 83.0, 82.0, 83.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 132.0, 142.0, 131.0, 144.0, 130.0, 129.0, 183.0, 140.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 189.0, 194.0, 200.0, 186.0, 191.0, 194.0, 184.0, 179.0, 188.0], "value": 188.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 72.0, 78.0, 75.0, 71.0, 71.0, 71.0, 70.0, 70.0], "value": 72.5, "unit": "score"}]}]} 20:56:48 INFO - Return code: 0 20:56:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:56:48 INFO - # TBPL SUCCESS # 20:56:48 INFO - Running post-action listener: _resource_record_post_action 20:56:48 INFO - [mozharness: 2017-05-08 03:56:48.856544Z] Finished run-tests step (success) 20:56:48 INFO - Running post-run listener: _resource_record_post_run 20:56:48 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 7958528; Write bytes: 346554368; Read time: 1444; Write time: 204244 20:56:48 INFO - TinderboxPrint: CPU usage
13.3% 20:56:48 INFO - TinderboxPrint: I/O read bytes / time
7,958,528 / 1,444 20:56:48 INFO - TinderboxPrint: I/O write bytes / time
346,554,368 / 204,244 20:56:48 INFO - TinderboxPrint: CPU idle
8,297.5 (86.7%) 20:56:48 INFO - TinderboxPrint: CPU user
1,214.9 (12.7%) 20:56:48 INFO - TinderboxPrint: Swap in / out
0 / 0 20:56:48 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 4096; Write bytes: 109215744; Read time: 72; Write time: 74120 20:56:48 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 5611520; Write bytes: 237338624; Read time: 1232; Write time: 130124 20:56:49 INFO - Running post-run listener: _upload_blobber_files 20:56:49 INFO - Blob upload gear active. 20:56:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:56:49 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 20:56:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:56:49 INFO - (blobuploader) - INFO - Open directory for files ... 20:56:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:56:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:56:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:56:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:56:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:56:54 INFO - (blobuploader) - INFO - Done attempting. 20:56:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:56:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:56:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:56:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:56:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:56:55 INFO - (blobuploader) - INFO - Done attempting. 20:56:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:56:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:56:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:56:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:56:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:56:56 INFO - (blobuploader) - INFO - Done attempting. 20:56:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:56:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:56:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:56:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:56:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:56:56 INFO - (blobuploader) - INFO - Done attempting. 20:56:56 INFO - (blobuploader) - INFO - Iteration through files over. 20:56:56 INFO - Return code: 0 20:56:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:56:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:56:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/097ec2cc739f0dc42162b0c8095239b28e1a1e2732478b8c857d9a9c349dd251645826ae3cc8f65b1ed22e06bc8a4c492a3cbaa551cf7683f272d0920a3492e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aaa1c6485dbe07d9598f93f4159fc00ee1e3e19b1b763786f71758322fda34265a5789b41bcadf5b2d9e614cc60d42e56833211107bb6399f21fd38b3ded1e45", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c9684f9c7201a661d5686589f050a467b3f41b9d3389fd294b108c00b4450c6ae1fdd7d7f6993a0bd4fc51ea87ace8fb39a7a9e874b5834fa8eb005c0214095e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c85fd631a80b36752fd97249f042da0aed4c3219b681d16e6073474287aa70f21e907e5b6e7167c68a39cc772ca3a4572b86f1566064fbbd071e702f3c00aea"} 20:56:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:56:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:56:56 INFO - Contents: 20:56:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/097ec2cc739f0dc42162b0c8095239b28e1a1e2732478b8c857d9a9c349dd251645826ae3cc8f65b1ed22e06bc8a4c492a3cbaa551cf7683f272d0920a3492e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aaa1c6485dbe07d9598f93f4159fc00ee1e3e19b1b763786f71758322fda34265a5789b41bcadf5b2d9e614cc60d42e56833211107bb6399f21fd38b3ded1e45", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c9684f9c7201a661d5686589f050a467b3f41b9d3389fd294b108c00b4450c6ae1fdd7d7f6993a0bd4fc51ea87ace8fb39a7a9e874b5834fa8eb005c0214095e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c85fd631a80b36752fd97249f042da0aed4c3219b681d16e6073474287aa70f21e907e5b6e7167c68a39cc772ca3a4572b86f1566064fbbd071e702f3c00aea"} 20:56:56 INFO - Running post-run listener: copy_logs_to_upload_dir 20:56:56 INFO - Copying logs to upload dir... 20:56:56 INFO - mkdir: /builds/slave/test/build/upload/logs 20:56:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.892074 ========= master_lag: -0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-05-07 20:56:57.097859) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-07 20:56:57.104969) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/097ec2cc739f0dc42162b0c8095239b28e1a1e2732478b8c857d9a9c349dd251645826ae3cc8f65b1ed22e06bc8a4c492a3cbaa551cf7683f272d0920a3492e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aaa1c6485dbe07d9598f93f4159fc00ee1e3e19b1b763786f71758322fda34265a5789b41bcadf5b2d9e614cc60d42e56833211107bb6399f21fd38b3ded1e45", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c9684f9c7201a661d5686589f050a467b3f41b9d3389fd294b108c00b4450c6ae1fdd7d7f6993a0bd4fc51ea87ace8fb39a7a9e874b5834fa8eb005c0214095e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c85fd631a80b36752fd97249f042da0aed4c3219b681d16e6073474287aa70f21e907e5b6e7167c68a39cc772ca3a4572b86f1566064fbbd071e702f3c00aea"} build_url:https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011133 build_url: 'https://queue.taskcluster.net/v1/task/L3lETsAqR0et1hVv4ApFkA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/097ec2cc739f0dc42162b0c8095239b28e1a1e2732478b8c857d9a9c349dd251645826ae3cc8f65b1ed22e06bc8a4c492a3cbaa551cf7683f272d0920a3492e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aaa1c6485dbe07d9598f93f4159fc00ee1e3e19b1b763786f71758322fda34265a5789b41bcadf5b2d9e614cc60d42e56833211107bb6399f21fd38b3ded1e45", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c9684f9c7201a661d5686589f050a467b3f41b9d3389fd294b108c00b4450c6ae1fdd7d7f6993a0bd4fc51ea87ace8fb39a7a9e874b5834fa8eb005c0214095e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c85fd631a80b36752fd97249f042da0aed4c3219b681d16e6073474287aa70f21e907e5b6e7167c68a39cc772ca3a4572b86f1566064fbbd071e702f3c00aea"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-07 20:56:57.131836) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 20:56:57.132126) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1494214481.554930-1481531063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004349 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 20:56:57.216680) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-07 20:56:57.217010) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-07 20:56:57.217502) ========= ========= Total master_lag: 0.04 =========