builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-046 starttime: 1493872172.02 results: success (0) revision: 4a6a71f4aa22e4dc3961884ce505ce34bdd799a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 21:29:32.017428) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 21:29:32.017878) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 21:29:32.018152) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 21:29:32.033473) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 21:29:32.033862) ========= 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=652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-03 21:29:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 220M=0s 2017-05-03 21:29:32 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.168127 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 21:29:32.216361) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 21:29:32.219677) ========= 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=652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022139 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 21:29:32.300569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 21:29:32.300906) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4a6a71f4aa22e4dc3961884ce505ce34bdd799a2 --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 4a6a71f4aa22e4dc3961884ce505ce34bdd799a2 --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=652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-03 21:29:32,656 truncating revision to first 12 chars 2017-05-03 21:29:32,656 Setting DEBUG logging. 2017-05-03 21:29:32,656 attempt 1/10 2017-05-03 21:29:32,656 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4a6a71f4aa22?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-03 21:29:32,965 unpacking tar archive at: mozilla-central-4a6a71f4aa22/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631664 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 21:29:32.949216) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 21:29:32.949516) ========= script_repo_revision: 4a6a71f4aa22e4dc3961884ce505ce34bdd799a2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 21:29:32.952902) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 21:29:32.953167) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 21:29:32.963382) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-03 21:29:32.963688) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:29:33 INFO - MultiFileLogger online at 20170503 21:29:33 in /builds/slave/test 21:29:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:29:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:29:33 INFO - {'append_to_log': False, 21:29:33 INFO - 'base_work_dir': '/builds/slave/test', 21:29:33 INFO - 'blob_upload_branch': 'Firefox', 21:29:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:29:33 INFO - 'branch': 'Firefox', 21:29:33 INFO - 'buildbot_json_path': 'buildprops.json', 21:29:33 INFO - 'config_files': ('talos/linux_config.py',), 21:29:33 INFO - 'default_actions': ('clobber', 21:29:33 INFO - 'read-buildbot-config', 21:29:33 INFO - 'download-and-extract', 21:29:33 INFO - 'populate-webroot', 21:29:33 INFO - 'create-virtualenv', 21:29:33 INFO - 'install', 21:29:33 INFO - 'run-tests'), 21:29:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:29:33 INFO - 'download_minidump_stackwalk': True, 21:29:33 INFO - 'download_symbols': 'ondemand', 21:29:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:29:33 INFO - 'tooltool.py': '/tools/tooltool.py', 21:29:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:29:33 INFO - '/tools/misc-python/virtualenv.py')}, 21:29:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:29:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:29:33 INFO - 'gecko_profile': False, 21:29:33 INFO - 'gecko_profile_interval': 0, 21:29:33 INFO - 'installer_path': 'installer.exe', 21:29:33 INFO - 'log_level': 'info', 21:29:33 INFO - 'log_name': 'talos', 21:29:33 INFO - 'log_to_console': True, 21:29:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:29:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:29:33 INFO - 'opt_config_files': (), 21:29:33 INFO - 'pip_index': False, 21:29:33 INFO - 'suite': 'dromaeojs-e10s', 21:29:33 INFO - 'system_bits': '32', 21:29:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:29:33 INFO - 'title': 'talos-linux64-ix-046', 21:29:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:29:33 INFO - 'use_talos_json': True, 21:29:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:29:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:29:33 INFO - 'work_dir': 'build'} 21:29:33 INFO - [mozharness: 2017-05-04 04:29:33.416912Z] Running clobber step. 21:29:33 INFO - Running pre-action listener: _resource_record_pre_action 21:29:33 INFO - Running main action method: clobber 21:29:33 INFO - rmtree: /builds/slave/test/build 21:29:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:29:34 INFO - Running post-action listener: _resource_record_post_action 21:29:34 INFO - [mozharness: 2017-05-04 04:29:34.346835Z] Finished clobber step (success) 21:29:34 INFO - [mozharness: 2017-05-04 04:29:34.346935Z] Running read-buildbot-config step. 21:29:34 INFO - Running pre-action listener: _resource_record_pre_action 21:29:34 INFO - Running main action method: read_buildbot_config 21:29:34 INFO - Using buildbot properties: 21:29:34 INFO - { 21:29:34 INFO - "project": "", 21:29:34 INFO - "product": "firefox", 21:29:34 INFO - "who": "ihsiao@mozilla.com", 21:29:34 INFO - "installer_path": "public/build/target.tar.bz2", 21:29:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 21:29:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 21:29:34 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 21:29:34 INFO - "stage_platform": "linux64-stylo", 21:29:34 INFO - "basedir": "/builds/slave/test", 21:29:34 INFO - "buildnumber": 76, 21:29:34 INFO - "platform": "ubuntu64_hw_stylo", 21:29:34 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:29:34 INFO - "slavebuilddir": "test", 21:29:34 INFO - "taskId": "TemBO-iURpmdwvTz9HsaiA", 21:29:34 INFO - "branch": "mozilla-central", 21:29:34 INFO - "script_repo_revision": "production", 21:29:34 INFO - "revision": "4a6a71f4aa22e4dc3961884ce505ce34bdd799a2", 21:29:34 INFO - "slavename": "talos-linux64-ix-046", 21:29:34 INFO - "repo_path": "mozilla-central" 21:29:34 INFO - } 21:29:34 INFO - Finding installer, test and symbols from parent task. 21:29:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TemBO-iURpmdwvTz9HsaiA'}, attempt #1 21:29:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TemBO-iURpmdwvTz9HsaiA'}, attempt #1 21:29:35 INFO - Task dependencies: UrqE72RcRiKfY_A_rSjNgw 21:29:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw'}, attempt #1 21:29:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.tar.bz2 21:29:35 INFO - Set test_url: https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/test_packages.json 21:29:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.crashreporter-symbols.zip 21:29:35 INFO - Running post-action listener: _resource_record_post_action 21:29:35 INFO - [mozharness: 2017-05-04 04:29:35.700651Z] Finished read-buildbot-config step (success) 21:29:35 INFO - [mozharness: 2017-05-04 04:29:35.700869Z] Running download-and-extract step. 21:29:35 INFO - Running pre-action listener: _resource_record_pre_action 21:29:35 INFO - Running main action method: download_and_extract 21:29:35 INFO - mkdir: /builds/slave/test/build/tests 21:29:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:35 INFO - trying https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.test_packages.json 21:29:35 INFO - Downloading https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:29:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:29:36 INFO - Downloaded 986 bytes. 21:29:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:29:36 INFO - Using the following test package requirements: 21:29:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:29:36 INFO - u'common': [u'target.common.tests.zip'], 21:29:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:29:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:29:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:29:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:29:36 INFO - u'mozbase': [u'target.common.tests.zip'], 21:29:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:29:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:29:36 INFO - u'web-platform': [u'target.common.tests.zip', 21:29:36 INFO - u'target.web-platform.tests.zip'], 21:29:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:29:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 21:29:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.common.tests.zip 21:29:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:29:36 INFO - Fetch https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.common.tests.zip into memory 21:29:37 INFO - Content-Length response header: 58441481 21:29:37 INFO - Bytes received: 58441481 21:29:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 21:29:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.common.tests.zip 21:29:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:29:47 INFO - Fetch https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.common.tests.zip into memory 21:29:48 INFO - Content-Length response header: 58441481 21:29:48 INFO - Bytes received: 58441481 21:29:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.talos.tests.zip 21:29:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:29:59 INFO - Fetch https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.talos.tests.zip into memory 21:29:59 INFO - Content-Length response header: 14408809 21:29:59 INFO - Bytes received: 14408809 21:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:00 INFO - trying https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.tar.bz2 21:30:00 INFO - Downloading https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:30:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:30:01 INFO - Downloaded 59968289 bytes. 21:30:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.tar.bz2 21:30:01 INFO - mkdir: /builds/slave/test/properties 21:30:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:30:01 INFO - Writing to file /builds/slave/test/properties/build_url 21:30:01 INFO - Contents: 21:30:01 INFO - build_url:https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.tar.bz2 21:30:01 INFO - Running post-action listener: _resource_record_post_action 21:30:01 INFO - Running post-action listener: set_extra_try_arguments 21:30:01 INFO - [mozharness: 2017-05-04 04:30:01.192456Z] Finished download-and-extract step (success) 21:30:01 INFO - [mozharness: 2017-05-04 04:30:01.192552Z] Running populate-webroot step. 21:30:01 INFO - Running pre-action listener: _resource_record_pre_action 21:30:01 INFO - Running main action method: populate_webroot 21:30:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:30:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:30:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:30:01 INFO - '--tppagecycles', 21:30:01 INFO - '7'], 21:30:01 INFO - 'tests': ['tsvgm']}}, 21:30:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:30:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:30:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:30:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:30:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:30:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:30:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:30:01 INFO - 'talos_options': ['--disable-e10s'], 21:30:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:30:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:30:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:30:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:30:01 INFO - 'talos_options': ['--disable-e10s'], 21:30:01 INFO - 'tests': ['damp', 'tps']}, 21:30:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:30:01 INFO - 'tests': ['damp', 'tps']}, 21:30:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:30:01 INFO - 'tests': ['dromaeo_dom']}, 21:30:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:30:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:30:01 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 21:30:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:30:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:30:01 INFO - 'tests': ['a11yr', 21:30:01 INFO - 'ts_paint', 21:30:01 INFO - 'tpaint', 21:30:01 INFO - 'sessionrestore', 21:30:01 INFO - 'sessionrestore_no_auto_restore', 21:30:01 INFO - 'tabpaint']}, 21:30:01 INFO - 'other-e10s': {'tests': ['a11yr', 21:30:01 INFO - 'ts_paint', 21:30:01 INFO - 'tpaint', 21:30:01 INFO - 'sessionrestore', 21:30:01 INFO - 'sessionrestore_no_auto_restore', 21:30:01 INFO - 'tabpaint']}, 21:30:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:30:01 INFO - 'ts_paint', 21:30:01 INFO - 'tpaint', 21:30:01 INFO - 'sessionrestore', 21:30:01 INFO - 'sessionrestore_no_auto_restore', 21:30:01 INFO - 'tabpaint']}, 21:30:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:30:01 INFO - 'ts_paint', 21:30:01 INFO - 'tpaint', 21:30:01 INFO - 'sessionrestore', 21:30:01 INFO - 'sessionrestore_no_auto_restore', 21:30:01 INFO - 'tabpaint']}, 21:30:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:30:01 INFO - 'tests': ['a11yr', 21:30:01 INFO - 'ts_paint', 21:30:01 INFO - 'tpaint', 21:30:01 INFO - 'sessionrestore', 21:30:01 INFO - 'sessionrestore_no_auto_restore', 21:30:01 INFO - 'tabpaint']}, 21:30:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:30:01 INFO - 'tests': ['a11yr', 21:30:01 INFO - 'ts_paint', 21:30:01 INFO - 'tpaint', 21:30:01 INFO - 'sessionrestore', 21:30:01 INFO - 'sessionrestore_no_auto_restore', 21:30:01 INFO - 'tabpaint']}, 21:30:01 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 21:30:01 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 21:30:01 INFO - 'bloom_basic_ref']}, 21:30:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:30:01 INFO - 'tests': ['tsvgx', 21:30:01 INFO - 'tsvgr_opacity', 21:30:01 INFO - 'tart', 21:30:01 INFO - 'tscrollx', 21:30:01 INFO - 'cart', 21:30:01 INFO - 'tsvg_static']}, 21:30:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:30:01 INFO - 'tsvgr_opacity', 21:30:01 INFO - 'tart', 21:30:01 INFO - 'tscrollx', 21:30:01 INFO - 'cart', 21:30:01 INFO - 'tsvg_static']}, 21:30:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:30:01 INFO - 'talos_options': ['--disable-e10s'], 21:30:01 INFO - 'tests': ['tp5o']}, 21:30:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:30:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:30:01 INFO - 'talos_options': ['--disable-e10s', 21:30:01 INFO - '--xperf_path', 21:30:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:30:01 INFO - 'tests': ['tp5n']}, 21:30:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:30:01 INFO - 'talos_options': ['--xperf_path', 21:30:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:30:01 INFO - 'tests': ['tp5n']}}, 21:30:01 INFO - 'talos.zip': {'path': '', 21:30:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:30:01 INFO - Running post-action listener: _resource_record_post_action 21:30:01 INFO - [mozharness: 2017-05-04 04:30:01.206294Z] Finished populate-webroot step (success) 21:30:01 INFO - [mozharness: 2017-05-04 04:30:01.206395Z] Running create-virtualenv step. 21:30:01 INFO - Running pre-action listener: _resource_record_pre_action 21:30:01 INFO - Running main action method: create_virtualenv 21:30:01 INFO - Creating virtualenv /builds/slave/test/build/venv 21:30:01 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 21:30:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:30:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:30:01 INFO - Using real prefix '/usr' 21:30:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:30:01 INFO - Installing distribute.............................................................................................................................................................................................done. 21:30:03 INFO - Installing pip.................done. 21:30:03 INFO - Return code: 0 21:30:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:30:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:30:03 INFO - Reading from file tmpfile_stdout 21:30:03 INFO - Output received: 21:30:03 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) 21:30:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:30: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')]} 21:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30: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')]} 21:30:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e80b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e290>, '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 0x1e7eb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f040>, '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': '652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889', '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 21:30:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:30:04 INFO - Using env: {'DISPLAY': ':0', 21:30:04 INFO - 'HOME': '/home/cltbld', 21:30:04 INFO - 'LANG': 'en_US.UTF-8', 21:30:04 INFO - 'LANGUAGE': 'en_US:en', 21:30:04 INFO - 'LOGNAME': 'cltbld', 21:30:04 INFO - 'MAIL': '/var/mail/cltbld', 21:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:04 INFO - 'MOZ_NO_REMOTE': '1', 21:30:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:04 INFO - 'NO_EM_RESTART': '1', 21:30:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:04 INFO - 'PWD': '/builds/slave/test', 21:30:04 INFO - 'SHELL': '/bin/bash', 21:30:04 INFO - 'SHLVL': '1', 21:30:04 INFO - 'TERM': 'linux', 21:30:04 INFO - 'TMOUT': '86400', 21:30:04 INFO - 'USER': 'cltbld', 21:30:04 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889', 21:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:04 INFO - '_': '/tools/buildbot/bin/python'} 21:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:04 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 21:30:04 INFO - Cleaning up... 21:30:04 INFO - Return code: 0 21:30:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1be31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e80b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e290>, '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 0x1e7eb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f040>, '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': '652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889', '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 21:30:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:30:04 INFO - Using env: {'DISPLAY': ':0', 21:30:04 INFO - 'HOME': '/home/cltbld', 21:30:04 INFO - 'LANG': 'en_US.UTF-8', 21:30:04 INFO - 'LANGUAGE': 'en_US:en', 21:30:04 INFO - 'LOGNAME': 'cltbld', 21:30:04 INFO - 'MAIL': '/var/mail/cltbld', 21:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:04 INFO - 'MOZ_NO_REMOTE': '1', 21:30:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:04 INFO - 'NO_EM_RESTART': '1', 21:30:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:04 INFO - 'PWD': '/builds/slave/test', 21:30:04 INFO - 'SHELL': '/bin/bash', 21:30:04 INFO - 'SHLVL': '1', 21:30:04 INFO - 'TERM': 'linux', 21:30:04 INFO - 'TMOUT': '86400', 21:30:04 INFO - 'USER': 'cltbld', 21:30:04 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889', 21:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:04 INFO - '_': '/tools/buildbot/bin/python'} 21:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:04 INFO - Downloading/unpacking psutil>=3.1.1 21:30:04 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 21:30:04 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 21:30:04 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 21:30:04 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 21:30:04 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 21:30:04 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 21:30:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:30:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:30:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:30:05 INFO - Installing collected packages: psutil 21:30:05 INFO - Running setup.py install for psutil 21:30:05 INFO - building 'psutil._psutil_linux' extension 21:30:05 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 21:30:05 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 21:30:05 INFO - building 'psutil._psutil_posix' extension 21:30:05 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 21:30:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:30:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:30:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:30:06 INFO - Successfully installed psutil 21:30:06 INFO - Cleaning up... 21:30:06 INFO - Return code: 0 21:30:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e80b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e290>, '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 0x1e7eb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f040>, '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': '652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889', '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 21:30:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:30:06 INFO - Using env: {'DISPLAY': ':0', 21:30:06 INFO - 'HOME': '/home/cltbld', 21:30:06 INFO - 'LANG': 'en_US.UTF-8', 21:30:06 INFO - 'LANGUAGE': 'en_US:en', 21:30:06 INFO - 'LOGNAME': 'cltbld', 21:30:06 INFO - 'MAIL': '/var/mail/cltbld', 21:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:06 INFO - 'MOZ_NO_REMOTE': '1', 21:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:06 INFO - 'NO_EM_RESTART': '1', 21:30:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:06 INFO - 'PWD': '/builds/slave/test', 21:30:06 INFO - 'SHELL': '/bin/bash', 21:30:06 INFO - 'SHLVL': '1', 21:30:06 INFO - 'TERM': 'linux', 21:30:06 INFO - 'TMOUT': '86400', 21:30:06 INFO - 'USER': 'cltbld', 21:30:06 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889', 21:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:06 INFO - '_': '/tools/buildbot/bin/python'} 21:30:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:30:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:30:08 INFO - Installing collected packages: mozsystemmonitor 21:30:08 INFO - Running setup.py install for mozsystemmonitor 21:30:08 INFO - Successfully installed mozsystemmonitor 21:30:08 INFO - Cleaning up... 21:30:08 INFO - Return code: 0 21:30:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e80b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e290>, '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 0x1e7eb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f040>, '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': '652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889', '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 21:30:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:30:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:30:08 INFO - Using env: {'DISPLAY': ':0', 21:30:08 INFO - 'HOME': '/home/cltbld', 21:30:08 INFO - 'LANG': 'en_US.UTF-8', 21:30:08 INFO - 'LANGUAGE': 'en_US:en', 21:30:08 INFO - 'LOGNAME': 'cltbld', 21:30:08 INFO - 'MAIL': '/var/mail/cltbld', 21:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:08 INFO - 'MOZ_NO_REMOTE': '1', 21:30:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:08 INFO - 'NO_EM_RESTART': '1', 21:30:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:08 INFO - 'PWD': '/builds/slave/test', 21:30:08 INFO - 'SHELL': '/bin/bash', 21:30:08 INFO - 'SHLVL': '1', 21:30:08 INFO - 'TERM': 'linux', 21:30:08 INFO - 'TMOUT': '86400', 21:30:08 INFO - 'USER': 'cltbld', 21:30:08 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889', 21:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:08 INFO - '_': '/tools/buildbot/bin/python'} 21:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:08 INFO - Downloading/unpacking jsonschema==2.5.1 21:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:30:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:10 INFO - Downloading functools32-3.2.3-2.tar.gz 21:30:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:30:10 INFO - warning: no files found matching '*.txt' 21:30:10 INFO - no previously-included directories found matching 'build' 21:30:10 INFO - no previously-included directories found matching 'dist' 21:30:10 INFO - no previously-included directories found matching '.git*' 21:30:10 INFO - Installing collected packages: jsonschema, functools32 21:30:10 INFO - Running setup.py install for functools32 21:30:10 INFO - warning: no files found matching '*.txt' 21:30:10 INFO - no previously-included directories found matching 'build' 21:30:10 INFO - no previously-included directories found matching 'dist' 21:30:10 INFO - no previously-included directories found matching '.git*' 21:30:10 INFO - Successfully installed jsonschema functools32 21:30:10 INFO - Cleaning up... 21:30:10 INFO - Return code: 0 21:30:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e80b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e290>, '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 0x1e7eb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f040>, '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': '652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889', '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 21:30:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:30:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:30:10 INFO - Using env: {'DISPLAY': ':0', 21:30:10 INFO - 'HOME': '/home/cltbld', 21:30:10 INFO - 'LANG': 'en_US.UTF-8', 21:30:10 INFO - 'LANGUAGE': 'en_US:en', 21:30:10 INFO - 'LOGNAME': 'cltbld', 21:30:10 INFO - 'MAIL': '/var/mail/cltbld', 21:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:10 INFO - 'MOZ_NO_REMOTE': '1', 21:30:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:10 INFO - 'NO_EM_RESTART': '1', 21:30:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:10 INFO - 'PWD': '/builds/slave/test', 21:30:10 INFO - 'SHELL': '/bin/bash', 21:30:10 INFO - 'SHLVL': '1', 21:30:10 INFO - 'TERM': 'linux', 21:30:10 INFO - 'TMOUT': '86400', 21:30:10 INFO - 'USER': 'cltbld', 21:30:10 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889', 21:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:10 INFO - '_': '/tools/buildbot/bin/python'} 21:30:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:30:10 INFO - Cleaning up... 21:30:10 INFO - Return code: 0 21:30:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e80b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e290>, '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 0x1e7eb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f040>, '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': '652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889', '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 21:30:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:30:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:30:10 INFO - Using env: {'DISPLAY': ':0', 21:30:10 INFO - 'HOME': '/home/cltbld', 21:30:10 INFO - 'LANG': 'en_US.UTF-8', 21:30:10 INFO - 'LANGUAGE': 'en_US:en', 21:30:10 INFO - 'LOGNAME': 'cltbld', 21:30:10 INFO - 'MAIL': '/var/mail/cltbld', 21:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:10 INFO - 'MOZ_NO_REMOTE': '1', 21:30:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:10 INFO - 'NO_EM_RESTART': '1', 21:30:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:10 INFO - 'PWD': '/builds/slave/test', 21:30:10 INFO - 'SHELL': '/bin/bash', 21:30:10 INFO - 'SHLVL': '1', 21:30:10 INFO - 'TERM': 'linux', 21:30:10 INFO - 'TMOUT': '86400', 21:30:10 INFO - 'USER': 'cltbld', 21:30:10 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889', 21:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:10 INFO - '_': '/tools/buildbot/bin/python'} 21:30:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:10 INFO - Downloading/unpacking blobuploader==1.2.4 21:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:11 INFO - Downloading blobuploader-1.2.4.tar.gz 21:30:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:30:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:30:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:12 INFO - Downloading docopt-0.6.1.tar.gz 21:30:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:30:12 INFO - Installing collected packages: blobuploader, requests, docopt 21:30:12 INFO - Running setup.py install for blobuploader 21:30:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:30:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:30:12 INFO - Running setup.py install for requests 21:30:12 INFO - Running setup.py install for docopt 21:30:12 INFO - Successfully installed blobuploader requests docopt 21:30:12 INFO - Cleaning up... 21:30:13 INFO - Return code: 0 21:30:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e80b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e290>, '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 0x1e7eb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f040>, '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': '652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889', '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 21:30:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:30:13 INFO - Using env: {'DISPLAY': ':0', 21:30:13 INFO - 'HOME': '/home/cltbld', 21:30:13 INFO - 'LANG': 'en_US.UTF-8', 21:30:13 INFO - 'LANGUAGE': 'en_US:en', 21:30:13 INFO - 'LOGNAME': 'cltbld', 21:30:13 INFO - 'MAIL': '/var/mail/cltbld', 21:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:13 INFO - 'MOZ_NO_REMOTE': '1', 21:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:13 INFO - 'NO_EM_RESTART': '1', 21:30:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:13 INFO - 'PWD': '/builds/slave/test', 21:30:13 INFO - 'SHELL': '/bin/bash', 21:30:13 INFO - 'SHLVL': '1', 21:30:13 INFO - 'TERM': 'linux', 21:30:13 INFO - 'TMOUT': '86400', 21:30:13 INFO - 'USER': 'cltbld', 21:30:13 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889', 21:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:13 INFO - '_': '/tools/buildbot/bin/python'} 21:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:30:13 INFO - Running setup.py (path:/tmp/pip-BxRZ7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:30:13 INFO - Running setup.py (path:/tmp/pip-KHZXPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:30:13 INFO - Running setup.py (path:/tmp/pip-TwuPEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:30:13 INFO - Running setup.py (path:/tmp/pip-Zs2X5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:30:13 INFO - Running setup.py (path:/tmp/pip-Sg640j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:30:13 INFO - Running setup.py (path:/tmp/pip-EgJ02X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:30:13 INFO - Running setup.py (path:/tmp/pip-sKdeNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:30:13 INFO - Running setup.py (path:/tmp/pip-bfsaRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:30:13 INFO - Running setup.py (path:/tmp/pip-vmiRrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:30:13 INFO - Running setup.py (path:/tmp/pip-kt3MgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:30:13 INFO - Running setup.py (path:/tmp/pip-x4QdKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:30:14 INFO - Running setup.py (path:/tmp/pip-6amyjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:30:14 INFO - Running setup.py (path:/tmp/pip-4Wd34b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:30:14 INFO - Running setup.py (path:/tmp/pip-ixT00S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:14 INFO - Running setup.py (path:/tmp/pip-lGjvy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:30:14 INFO - Running setup.py (path:/tmp/pip-Zb5jJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:30:14 INFO - Running setup.py (path:/tmp/pip-DwYzfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:30:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:30:14 INFO - Running setup.py install for manifestparser 21:30:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:30:14 INFO - Running setup.py install for mozcrash 21:30:14 INFO - Running setup.py install for mozdebug 21:30:14 INFO - Running setup.py install for mozdevice 21:30:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:30:14 INFO - Running setup.py install for mozfile 21:30:14 INFO - Running setup.py install for mozhttpd 21:30:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:30:15 INFO - Running setup.py install for mozinfo 21:30:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:30:15 INFO - Running setup.py install for mozInstall 21:30:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:30:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:30:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:30:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:30:15 INFO - Running setup.py install for mozleak 21:30:15 INFO - Running setup.py install for mozlog 21:30:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:30:15 INFO - Running setup.py install for moznetwork 21:30:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:30:15 INFO - Running setup.py install for mozprocess 21:30:15 INFO - Running setup.py install for mozprofile 21:30:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:30:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:30:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:30:15 INFO - Running setup.py install for mozrunner 21:30:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:30:15 INFO - Running setup.py install for mozscreenshot 21:30:16 INFO - Running setup.py install for moztest 21:30:16 INFO - Running setup.py install for mozversion 21:30:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:30:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:30:16 INFO - Cleaning up... 21:30:16 INFO - Return code: 0 21:30:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e80b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e290>, '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 0x1e7eb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f040>, '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': '652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889', '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 21:30:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:30:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:30:16 INFO - Using env: {'DISPLAY': ':0', 21:30:16 INFO - 'HOME': '/home/cltbld', 21:30:16 INFO - 'LANG': 'en_US.UTF-8', 21:30:16 INFO - 'LANGUAGE': 'en_US:en', 21:30:16 INFO - 'LOGNAME': 'cltbld', 21:30:16 INFO - 'MAIL': '/var/mail/cltbld', 21:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:16 INFO - 'MOZ_NO_REMOTE': '1', 21:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:16 INFO - 'NO_EM_RESTART': '1', 21:30:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:16 INFO - 'PWD': '/builds/slave/test', 21:30:16 INFO - 'SHELL': '/bin/bash', 21:30:16 INFO - 'SHLVL': '1', 21:30:16 INFO - 'TERM': 'linux', 21:30:16 INFO - 'TMOUT': '86400', 21:30:16 INFO - 'USER': 'cltbld', 21:30:16 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889', 21:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:16 INFO - '_': '/tools/buildbot/bin/python'} 21:30:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:30:16 INFO - Running setup.py (path:/tmp/pip-9lwvdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:30:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:30:16 INFO - Running setup.py (path:/tmp/pip-kWy7NI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:30:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:30:16 INFO - Running setup.py (path:/tmp/pip-fnLlby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:30:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:30:16 INFO - Running setup.py (path:/tmp/pip-JbdpaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:30:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:30:16 INFO - Running setup.py (path:/tmp/pip-pmqEWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:30:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:30:16 INFO - Running setup.py (path:/tmp/pip-FNZQ8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:30:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:30:16 INFO - Running setup.py (path:/tmp/pip-m1GhxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:30:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:30:16 INFO - Running setup.py (path:/tmp/pip-qMcyEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:30:17 INFO - Running setup.py (path:/tmp/pip-HsKZ1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:30:17 INFO - Running setup.py (path:/tmp/pip-SaGIGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:30:17 INFO - Running setup.py (path:/tmp/pip-4P1ojm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:30:17 INFO - Running setup.py (path:/tmp/pip-Z3bi0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:30:17 INFO - Running setup.py (path:/tmp/pip-u_KRmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:30:17 INFO - Running setup.py (path:/tmp/pip-RJJFG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:17 INFO - Running setup.py (path:/tmp/pip-JJtT9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:30:17 INFO - Running setup.py (path:/tmp/pip-Mf234j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:30:17 INFO - Running setup.py (path:/tmp/pip-dbCZPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:30:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:18 INFO - Downloading blessings-1.6.tar.gz 21:30:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:30:18 INFO - Installing collected packages: blessings 21:30:18 INFO - Running setup.py install for blessings 21:30:18 INFO - Successfully installed blessings 21:30:18 INFO - Cleaning up... 21:30:19 INFO - Return code: 0 21:30:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:30:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:30:19 INFO - Reading from file tmpfile_stdout 21:30:19 INFO - Current package versions: 21:30:19 INFO - argparse == 1.2.1 21:30:19 INFO - blessings == 1.6 21:30:19 INFO - blobuploader == 1.2.4 21:30:19 INFO - docopt == 0.6.1 21:30:19 INFO - functools32 == 3.2.3-2 21:30:19 INFO - jsonschema == 2.5.1 21:30:19 INFO - manifestparser == 1.1 21:30:19 INFO - mozInstall == 1.12 21:30:19 INFO - mozcrash == 1.0 21:30:19 INFO - mozdebug == 0.1 21:30:19 INFO - mozdevice == 0.50 21:30:19 INFO - mozfile == 1.2 21:30:19 INFO - mozhttpd == 0.7 21:30:19 INFO - mozinfo == 0.9 21:30:19 INFO - mozleak == 0.1 21:30:19 INFO - mozlog == 3.4 21:30:19 INFO - moznetwork == 0.27 21:30:19 INFO - mozprocess == 0.25 21:30:19 INFO - mozprofile == 0.28 21:30:19 INFO - mozrunner == 6.13 21:30:19 INFO - mozscreenshot == 0.1 21:30:19 INFO - mozsystemmonitor == 0.3 21:30:19 INFO - moztest == 0.8 21:30:19 INFO - mozversion == 1.4 21:30:19 INFO - psutil == 3.1.1 21:30:19 INFO - requests == 1.2.3 21:30:19 INFO - wsgiref == 0.1.2 21:30:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e80b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e290>, '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 0x1e7eb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f040>, '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': '652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889', '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 21:30:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:30:19 INFO - Using env: {'DISPLAY': ':0', 21:30:19 INFO - 'HOME': '/home/cltbld', 21:30:19 INFO - 'LANG': 'en_US.UTF-8', 21:30:19 INFO - 'LANGUAGE': 'en_US:en', 21:30:19 INFO - 'LOGNAME': 'cltbld', 21:30:19 INFO - 'MAIL': '/var/mail/cltbld', 21:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:19 INFO - 'MOZ_NO_REMOTE': '1', 21:30:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:19 INFO - 'NO_EM_RESTART': '1', 21:30:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:19 INFO - 'PWD': '/builds/slave/test', 21:30:19 INFO - 'SHELL': '/bin/bash', 21:30:19 INFO - 'SHLVL': '1', 21:30:19 INFO - 'TERM': 'linux', 21:30:19 INFO - 'TMOUT': '86400', 21:30:19 INFO - 'USER': 'cltbld', 21:30:19 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889', 21:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:19 INFO - '_': '/tools/buildbot/bin/python'} 21:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:30:19 INFO - Cleaning up... 21:30:19 INFO - Return code: 0 21:30:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e80b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e290>, '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 0x1e7eb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f040>, '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': '652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889', '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 21:30:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:30:19 INFO - Using env: {'DISPLAY': ':0', 21:30:19 INFO - 'HOME': '/home/cltbld', 21:30:19 INFO - 'LANG': 'en_US.UTF-8', 21:30:19 INFO - 'LANGUAGE': 'en_US:en', 21:30:19 INFO - 'LOGNAME': 'cltbld', 21:30:19 INFO - 'MAIL': '/var/mail/cltbld', 21:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:19 INFO - 'MOZ_NO_REMOTE': '1', 21:30:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:19 INFO - 'NO_EM_RESTART': '1', 21:30:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:19 INFO - 'PWD': '/builds/slave/test', 21:30:19 INFO - 'SHELL': '/bin/bash', 21:30:19 INFO - 'SHLVL': '1', 21:30:19 INFO - 'TERM': 'linux', 21:30:19 INFO - 'TMOUT': '86400', 21:30:19 INFO - 'USER': 'cltbld', 21:30:19 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889', 21:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:19 INFO - '_': '/tools/buildbot/bin/python'} 21:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:30:19 INFO - Cleaning up... 21:30:19 INFO - Return code: 0 21:30:19 INFO - Running post-action listener: _resource_record_post_action 21:30:19 INFO - Running post-action listener: _start_resource_monitoring 21:30:19 INFO - Starting resource monitoring. 21:30:19 INFO - [mozharness: 2017-05-04 04:30:19.738227Z] Finished create-virtualenv step (success) 21:30:19 INFO - [mozharness: 2017-05-04 04:30:19.738704Z] Running install step. 21:30:19 INFO - Running pre-action listener: _resource_record_pre_action 21:30:19 INFO - Running main action method: install 21:30:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:30:19 INFO - Reading from file tmpfile_stdout 21:30:19 INFO - Detecting whether we're running mozinstall >=1.0... 21:30:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:30:20 INFO - Reading from file tmpfile_stdout 21:30:20 INFO - Output received: 21:30:20 INFO - Usage: mozinstall [options] installer 21:30:20 INFO - Options: 21:30:20 INFO - -h, --help show this help message and exit 21:30:20 INFO - -d DEST, --destination=DEST 21:30:20 INFO - Directory to install application into. [default: 21:30:20 INFO - "/builds/slave/test"] 21:30:20 INFO - --app=APP Application being installed. [default: firefox] 21:30:20 INFO - mkdir: /builds/slave/test/build/application 21:30:20 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'] 21:30:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:30:35 INFO - Reading from file tmpfile_stdout 21:30:35 INFO - Output received: 21:30:35 INFO - /builds/slave/test/build/application/firefox/firefox 21:30:35 INFO - Running post-action listener: _resource_record_post_action 21:30:35 INFO - [mozharness: 2017-05-04 04:30:35.360463Z] Finished install step (success) 21:30:35 INFO - [mozharness: 2017-05-04 04:30:35.360736Z] Running run-tests step. 21:30:35 INFO - Running pre-action listener: _resource_record_pre_action 21:30:35 INFO - Running main action method: run_tests 21:30:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:30:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:30:35 INFO - Python 2.7.3 21:30:35 INFO - Return code: 0 21:30:35 INFO - grabbing minidump binary from tooltool 21:30:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:35 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e290>, '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 0x1e7eb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7f040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:30:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:30:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:30:35 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:30:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:30:35 INFO - Return code: 0 21:30:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:30:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:30:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:30:35 INFO - ENV: RUST_BACKTRACE is now 1 21:30:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:30:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:30:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 21:30:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 21:30:35 INFO - Using env: {'DISPLAY': ':0', 21:30:35 INFO - 'HOME': '/home/cltbld', 21:30:35 INFO - 'LANG': 'en_US.UTF-8', 21:30:35 INFO - 'LANGUAGE': 'en_US:en', 21:30:35 INFO - 'LOGNAME': 'cltbld', 21:30:35 INFO - 'MAIL': '/var/mail/cltbld', 21:30:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:30:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:30:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:35 INFO - 'MOZ_NO_REMOTE': '1', 21:30:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:30:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:35 INFO - 'NO_EM_RESTART': '1', 21:30:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:35 INFO - 'PWD': '/builds/slave/test', 21:30:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:30:35 INFO - 'RUST_BACKTRACE': '1', 21:30:35 INFO - 'SHELL': '/bin/bash', 21:30:35 INFO - 'SHLVL': '1', 21:30:35 INFO - 'TERM': 'linux', 21:30:35 INFO - 'TMOUT': '86400', 21:30:35 INFO - 'USER': 'cltbld', 21:30:35 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889', 21:30:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:35 INFO - '_': '/tools/buildbot/bin/python'} 21:30:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 21:30:35 INFO - mozversion application_buildid: 20170504032323 21:30:35 INFO - mozversion application_changeset: 4a6a71f4aa22e4dc3961884ce505ce34bdd799a2 21:30:35 INFO - mozversion application_display_name: Nightly 21:30:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:30:35 INFO - mozversion application_name: Firefox 21:30:35 INFO - mozversion application_remotingname: firefox 21:30:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:30:35 INFO - mozversion application_vendor: Mozilla 21:30:35 INFO - mozversion application_version: 55.0a1 21:30:35 INFO - mozversion platform_buildid: 20170504032323 21:30:35 INFO - mozversion platform_changeset: 4a6a71f4aa22e4dc3961884ce505ce34bdd799a2 21:30:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:30:35 INFO - mozversion platform_version: 55.0a1 21:30:35 INFO - using testdate: 1493872235 21:30:35 INFO - actual date: 1493872235 21:30:35 INFO - starting webserver on 'localhost:55107' 21:30:35 INFO - SUITE-START | Running 2 tests 21:30:35 INFO - TEST-START | dromaeo_css 21:30:35 INFO - operating with platform_type : linux_ 21:30:35 INFO - Initialising browser for dromaeo_css test... 21:30:35 INFO - TEST-INFO | started process 2110 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHpLQDG/profile http://localhost:55107/getInfo.html) 21:30:39 INFO - PID 2110 | __metrics Screen width/height:1600/1200 21:30:39 INFO - PID 2110 | colorDepth:24 21:30:39 INFO - PID 2110 | Browser inner width/height: 1024/695 21:30:39 INFO - PID 2110 | __metrics 21:30:41 INFO - TEST-INFO | 2110: exit 0 21:30:41 INFO - Browser initialized. 21:30:41 INFO - Running cycle 1/1 for dromaeo_css test... 21:30:41 INFO - TEST-INFO | started process 2300 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHpLQDG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:30:53 INFO - PID 2300 | RSS: Main: 174866432 21:30:53 INFO - PID 2300 | 21:34:00 INFO - PID 2300 | Cycle 1(1): loaded http://localhost:55107/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55107/tests/dromaeo/cssquery-ext.html) 21:34:01 INFO - PID 2300 | RSS: Main: 182194176 21:34:01 INFO - PID 2300 | 21:37:03 INFO - PID 2300 | Cycle 1(1): loaded http://localhost:55107/tests/dromaeo/cssquery-ext.html (next: http://localhost:55107/tests/dromaeo/cssquery-jquery.html) 21:37:04 INFO - PID 2300 | RSS: Main: 178028544 21:37:04 INFO - PID 2300 | 21:40:05 INFO - PID 2300 | Cycle 1(1): loaded http://localhost:55107/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55107/tests/dromaeo/cssquery-mootools.html) 21:40:06 INFO - PID 2300 | RSS: Main: 187748352 21:40:06 INFO - PID 2300 | 21:43:08 INFO - PID 2300 | Cycle 1(1): loaded http://localhost:55107/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55107/tests/dromaeo/cssquery-prototype.html) 21:43:09 INFO - PID 2300 | RSS: Main: 179101696 21:43:09 INFO - PID 2300 | 21:46:12 INFO - PID 2300 | Cycle 1(1): loaded http://localhost:55107/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55107/tests/dromaeo/cssquery-yui.html) 21:46:12 INFO - PID 2300 | RSS: Main: 184614912 21:46:12 INFO - PID 2300 | 21:49:14 INFO - PID 2300 | Cycle 1(1): loaded http://localhost:55107/tests/dromaeo/cssquery-yui.html (next: http://localhost:55107/tests/dromaeo/cssquery-dojo.html) 21:49:14 INFO - PID 2300 | RSS: Main: 188870656 21:49:14 INFO - PID 2300 | 21:49:14 INFO - PID 2300 | __start_tp_report 21:49:14 INFO - PID 2300 | _x_x_mozilla_page_load 21:49:14 INFO - PID 2300 | _x_x_mozilla_page_load_details 21:49:14 INFO - PID 2300 | |i|pagename|runs| 21:49:14 INFO - PID 2300 | |0;dojo.html;2759.62745029421;2775.2229375774764;2799.300174956261;2806.593044008619;2817.323842277854;5220.321358223426;5326;5346.2247974043785;5372.0330340538685;5392.838214853556;5278.736063196844;5279.63042587019;5330.387005494369;5407.540359069474;5428.9185662214995;4721.220998535237;4735.550122738335;4737.218358970775;4757.215059515176;4770.713757174563;4777;4817.325574419584;4823.927641085369;4832.830850920219;4844.90989527357;4517.932231016537;4629.907401851944;4648.047150334173;4761.523847615211;4770.236762118079;4667.043256132485;4675.602573781232;4691.671582989192;4731.408573928259;4742.668013239075;4608.446986361658;4628.884277893046;4656.115338085753;4662.72023678577;4684.8360307389075;5079.644424890259;5114.181730923072;5145.845624631267;5162.767675454614;5181.274621552986;5759.136129580555;5764;5780.439281394042;5781.508571771405;5827.242458480413;5753.741081651294;5778.5377169826315;5786.132080188006;5794;5810.418958104198;5240.475952404805;5335.86660333487;5338.439463856317;5354.571634269288;5359.088954877602;5826.329972053183;5842.211301474332;5851.239338885917;5867.354590994987;5873.706314684248;5594.524465420485;5619.775208991677;5716.028275193227;5716.571257155647;5721.39925307845;5748.281464816898;5823.650580965155;5825.970870145622;5831.562632802472;5863.442972917566;5700.572457065737;5722.198892155102;5729.770809167587;5731.656100633975;5746.5977381583725;5694.06048002075;5722.399148089474;5724.16999535065;5729.398413166641;5740.598158128891;4590.219662657356;4667.019925815549;4669.626429885601;4675.742834144086;4689.859304220879;4114.938275925863;4126.814293356806;4135.234981528367;4138.13099249155;4140.503139623264;4885.926711099336;4898.314236006961;4908.754562271872;4909.582685471703;4918.754062296871;5763.423657634203;5768.451997060272;5775.8556036099435;5780.410387143569;5795.449432303924;4748.596369308579;4858.684185527929;4868.634852386085;4911.336969509142;4920.827771027997;5086.720230387365;5093.057784309841;5112.258722485219;5149.227615857576;5154.664946778447;5313.973430132824;5324.680519168863;5345.518903298722;5358.19627055937;5392.730363481889;5581.469760372758;5688.63023903445;5723.370429252862;5732.111522713986;5733.9713301434895;5352.170413585901;5371.0869152244995;5378.300820893259;5397.433269506802;5403.675779453245;5558.805441809679;5598.664080155204;5607.691576963306;5719.771209151588;5741.684207368635;5846.736896839568;5856.9121463178935;5864.706764661664;5871.794487192928;5888.411158884077;5497.312835895513;5581.302337207849;5608.6073974823;5626.32484101894;5656.575756818337;5419.214213939035;5437.075697131576;5595;5602.915956260578;5609.747561359667;5477.178423236546;5563.415841336763;5592.608517403743;5592.916106258491;5617.915731264116;5627.212190293444;5629.296337957755;5633.380328163817;5639.238702775073;5642.153676948491;5300.602454815981;5453.454654534674;5462.6995515247045;5462.91805622908;5509.752061157177 21:49:14 INFO - PID 2300 | |1;ext.html;690.6374153569376;738.2801768275931;753.9736109236176;1052.5684469367561;1071.2073065931213;31314.68685313149;32112.197195070134;32191.19522011951;32246;32271.838640806793;33662.15844603886;33828.830855845685;34003.65996340036;34018.53647806915;34129.82935085327;6745.865082698343;6864.176298844146;6957.304269573053;6980.232174460805;6983.406410455117;6938.479614028943;6964.059851919977;7050.6827192776445;7052.083229180199;7052.858942821141;7001.544899581511;7003.684834182474;7030.753923612675;7039.894401583981;7041.471889608274;6922.342377474132;6967.024616553712;6974.197967233782;7010.298970103;7018.052562903994;6816.727330906758;6878.793636190922;6919.550229235084;6919.8962015569805;6934.341237582422;30843.074707758802;31056.378872422425;31121.533177002362;31142.37715245705;31152;3076.5692803007596;3088.8455577221275;3109.70457806508;3110.0358888744563;3117.2051126962706;23930.521389572285;24001.27996160118;24066;24118.276451706475;24121.035158593637;3166.0501849445072;3194.4409728297455;3202.551642770014;3205.1506350817053;3210.1653570071717;138968;139952;151288.43557822064;156860;157141;39198.804005979786;39270;39562.40656390157;39665.40501892474;39726.40410393846;41283.587164127974;41314.586854131674;41469.81627296588;41510;41577.584224157974;12647.873521264853;12693.873061269454;12710.110292279453;12724.1729287596;12807;10152.796944061078;10176.18590512772;10213.38719676807;10275.948620256851;10276.640317588848;12589.685257868627;12710.173838700455;12788;12792.081187821901;12882.549110781078;5282.841514754564;5423.423873660059;5476.479734425223;5507.7246137692955;5524.14375771756;882.2148288023536;908.2506931781174;935.1069728409353;953.7710949372239;960.8606752021058;20981.16075356999;21187.36437906865;21239.575208495742;21316.77983313757;21539.78460215409;967.5597603090717;1006.2503434941016;1015.9238057145743;1018.9286749927434;1033.2715435617872;10474.109700675528;11220.046296064926;11313.094952403788;11342.773144537063;11391.373474458818;180064;181358;181452;182089;182097;39656;40351.192976140315;40355.19289614191;40370.59629403727;40588.594114058484;1261.2873726344585;1301.1152416356779;1303.758804621148;1304.7260075384086;1305.5691621764795;19316.806831931503;19850;20227.898860505604;20364.28724994618;20573.794262057785;29029.854850725613;29401.264968375108;29469.705302946695;29471.26321841971;29472.41055178927;156890.21554892152;157958.2102089482;158658;158695;158734;27821.44357112806;28349;28719.71280287254;29410.55884161782;29980.250493737833;34740;35091.64908350884;35205.82397088101;35352;35758.8212058938;26954.73045269522;27331.863340683965;27591.31021724473;27787.44425111527;28073.298167545974;26937.595936061367;27156.864215678794;27738.306542336602;28468.145955621363;29284.853575731984;33308.333833322715;33681.83159084189;34343.31313373768;34861.47707784436;34982.12544686403;32352.514712278862;34329.313413731084;35997.46003809998;36180.81909590435;36204;25875.61186582165;27720.306992324546;28152.718472815828;28331.575026375034;28436.303280574222 21:49:14 INFO - PID 2300 | |2;jquery.html;419.8824329187827;421.6057985783291;422.13251767617555;430.9461317335333;451.31850905133257;17363.913180434098;17482.825171748278;17530.44422153412;17984.55038624035;18076.548086297833;18073.909630451828;18165.007396745423;18857.811421885777;18936.337228197015;19022;5456;5499.257600223968;5567.109262517998;5594.524465420423;5608.887822243552;5003.349564556603;5062.519060689247;5505.119180931052;5605.243292155547;5642.322921249456;5342.572594192456;5541.972290138544;5562.610617256793;5566.749496272657;5569.220309156722;5544.584156188302;5548.361938377098;5596.048671725816;5596.692181930012;5596.888062238773;4841.443234028096;4941.283513890466;4961.82633607822;4978.77595508203;4991.201407774739;21840.672389914165;21969.780302196934;21981.67027494589;22010.669839952414;22301.776982230294;1553.5494706535092;1597.3530720058395;1599.9040057596465;1626.2437966345587;1629.3075442936704;14419.206943618097;14501.564953051426;14642.267886605734;14933.626659333495;14955.102693838297;2079.5736873940805;2096.7379077615296;2123.0340195211143;2125.4048866317457;2181.5091604388886;84881.57559212226;85793.57103214506;85924.57037714834;87423.56288218581;88019.55990220008;10922.235443518877;11151.665450036511;11177;11282.943585282184;11396.772064558663;15576.766348504781;15688.215589220494;15689.764653530206;15712.13583252932;15733.68532629341;7363.374113200331;7603.391728661693;7630.847383052308;7924.167962363868;7942.12636609984;7110.360067593838;7211.170715367695;7297.270272972766;7348.77953661391;7353.70585176587;6935.826604334932;7048.224695283515;7087.822804429828;7120.35916767483;7176.856462870714;2020.777714451409;2039.082412914165;2043.038682864437;2046.8362530997485;2225.0321110317063;870.1037930931151;902.278177458031;904.6652738486671;913.4975763330142;937.1097457415347;16677.583060423585;16816.74774878378;17568.472945811645;17698.02722312149;17843.553911152325;897.7755561109723;907.832051070554;915.6612053540233;924.6440120553635;928.7724507495572;9159.90840091604;9485.573149208301;9702.466364349888;9804.46075465842;9862.852057219148;380704.4104347452;381792;382496;384097;388101;67580;67795.32204677988;68812;68824.31175688279;69543.3045669547;1048.7902419516279;1074.8763892152504;1103.9282446640943;1113.059464752283;1121.265571050963;14795.334209960361;15066.472673456376;15102.244887755787;15244.695106098037;15768;37300.44049339208;37304.44043339298;37404.81297593495;37685.434718479795;38540.80729596334;46030.769846151896;46696.766516167205;46851.765741171075;46933;48148.518514815805;7978;8191.262786349257;8197.71308004217;8285.047219569826;8410.705625303084;12204.87795122073;12741.681457963625;12896.16174948663;13003.674908127372;13105.14816536922;10892.82143571273;11087.667369978913;11253;11325.546978120783;11334.206605537533;10158.288919775545;10761.246712730033;10761.46192690378;10767.515461804394;10972.670819875417;10677.305975111592;10838.945805270923;11006.834897476705;11089.722756931142;11556.191066625255;8348.833023339621;8451.32389408858;8509.234168924826;8514.914850851412;8641.611127499153;11029.393383363991;11144.60993865211;11225.4387280634;11630.244034137753;11678.941605291919 21:49:14 INFO - PID 2300 | |3;mootools.html;1259.6472987563482;1294.3592921503857;1316.1576590981767;1316.891299146662;1322.4049177869954;9402.10679985402;9614.519274036296;9642.903570964289;10054.296199266055;10090.192784577235;9599.616015359377;9765.51172441377;9779.804403911918;9800.411975281488;9814.067663571966;2157.956840863186;2188.9014994325294;2189.1134090693295;2195.9011844467036;2197.560487902418;2079.6360636888558;2125.564259326842;2132.829373650112;2134.0716788197105;2135.882526461052;2144.7211862457857;2157.7194964654573;2185.09318632768;2185.901634426447;2198;2070.4409809351464;2097.664373700208;2105.8947052647304;2108.0408414171593;2120.692499587551;2017.213286818142;2074.0770357191054;2123.1613512662566;2126.9787302126933;2154.8707077575395;9801.264905132144;9808.509574521246;9840.507974601242;9866.950665246699;9896.55465504054;5377.46225377463;5545.584081193886;5549.528290095347;5552.472515111058;5562.443755624446;3101.379724055198;3297.950530742041;3313.1551454378978;3329.9500507492166;3369.3766653168996;1064.8243039898407;1082.247837752762;1103.0954617213888;1111.4998250787178;1119.043218048565;14810.111393316436;14886.478973235884;14952.850471495254;14994.250287485582;15037.473688420961;4434.534373890695;4494.4606647202545;4678.111158879802;4714.95285047152;4781.019890922353;10603.681889543326;10626.14990800734;10647.30792498485;10651.520681569347;10669.772976107692;5461.726913654302;5461.808836690697;5479.808206712746;5483.835484935458;5489;4876.804927802848;4988.176950803077;5052.5705315048635;5103.795848166106;5125.384953805567;3696.1129328960856;3797.487339209227;3813.3326667833016;3841.2893614681375;4035.2131334389514;1080.3895798873612;1097.0527314017681;1105.5577768892508;1113.4766659669942;1116.810142275815;690.102866273852;724.116577775124;731.6195578299255;740.76665850257;744.8286894014407;5383.973080134574;5398.352197736297;5477.315335583052;5528.723563821793;5555.8888822223325;522.2583930818247;537.6209772110652;541.0990700483729;543.8640339915021;548.3995025447128;3501.632328605511;3671.6511931366476;3679;3761.5110035695734;3843.8078096095082;12430;13303.3348332583;13373.93313033448;13416.865831341562;13424.194548327132;13082.476700932046;13252.602421927357;13265.535706250235;13274.402651880495;13275.203487790763;7214.242504537053;7534.171241163468;7586.848263034819;7617.390608751287;7627.046619172604;5375.946240537701;5452.454754524516;5512.641678290898;5573.7213139343685;5694.686792226467;11230.764615892082;11294.717632058935;11329.093672506344;11406.372649504357;11461.48423320936;11920.52317907274;11946.641600751991;11955.282683039046;11989;12223.877761222275;7277.563346199245;7957.1644977276555;8423.284020858051;8479.067302596834;8512.53181075022;9216.07839216073;9260.120288572574;9261.259099272176;9298.023707510885;9303.162715355651;7846;7981.281684648409;8108.878366824621;8181.5500147490075;8251.257386835214;7774.727884524241;7828.530288182727;7842.568658723597;7850.528968261922;7957.482763620346;7368.705251789868;7453.627318634155;7478.663460144416;7500.587467689329;7509.061367329084;5159.922601161061;5351.464853514617;5411.972940135274;5592.692401917933;5670.376258611632;5356.892862142813;5416.891662166813;5425.565954723534;5430.40265570779;5640.689762063126 21:49:14 INFO - PID 2300 | |4;prototype.html;374.12828110502534;395.06764036872977;399.9280129576676;400.2495321272614;408.79151632667333;5433.185022246665;5583.492457036597;5636.746346414411;5706.489144776301;5706.857328566788;5391.29913111296;5530.5299049580735;5563.356001818805;5579.191017302499;5618.932402843457;4398.8900277493;4408.42690450241;4411.250087485119;4415.359772832937;4417.977910110445;4058.208649313385;4202.432671589342;4231.217224813419;4406.889827754316;4418.403515525411;4158.7296825706235;4164.167166566684;4166.604172603597;4170.47869016373;4170.624643782059;4174.791260436966;4176.987614862162;4181.811818468176;4187.371894215861;4194.748315101104;3520.2079532105327;3603.1352475405974;3618.6924111450558;3647.7081833453526;3665.798381089039;5332.440093790174;5338.092524270884;5346;5349.786008559653;5397.46025397461;4887.486813884527;4891.486393928657;4894.36373271476;4896.534829191221;4901.5588597026435;5718.42019909682;5822.650640961556;5864.120381942743;5882.29412470502;5889.911651325234;4039.575844536311;4042.555318914917;4052.2705912935658;4061.4923134608175;4062.907602584671;6035.698215089228;6167.969160154171;6227.906581401283;6245.781397651061;6264.809686159615;4094.2016306819883;4118.320477121301;4135.627793498539;4136.565660605654;4147.00471886745;4188.183304255641;4196.433481479961;4200.348945913388;4201;4201.432806571135;4753.643476739258;4816.662833601615;4885.145099607555;4895.779689913891;4896.5103489651465;5877.324107727581;5878.706064696748;5901.822945311647;5907.232059832194;5920.5595803147635;1438.3167995202195;1455.978160327596;1458.3145921416917;1460.6348412896775;1461.072219140832;957.4111921168432;966.1015255812163;972.3825370889394;980.5538479991586;983.2576404814463;5112.872178195575;5114.846554603368;5137.948620513822;5144.408393034774;5180.171172612364;6149.5080393568405;6153.1693221415435;6164.537659675542;6190.133381326618;6193.349698281706;5002.52476014778;5099.260607211933;5131.409887862869;5136.717480538607;5144.588432925357;3222.113918672384;3255.674432556773;3266.7876588022177;3267.2485328374605;3272.132884785534;5516.9448305517235;5667.801626943037;5668.773249070074;5676.829695109153;5689.9146512802345;6243.219597550306;6262.843428914313;6269.7178626961895;6291.653959032297;6301.6534090625455;5618.943810561924;5630.18362337467;5641.661500309912;5644.379118296984;5656;5999.3100793407575;6087.869245763947;6107.053406721965;6108.725107370268;6147.600405973598;5852.385499522659;5981.282246130492;5996.4603185713495;6014.699265036818;6021.578489505692;5656.547476201977;5664.461876121762;5696.946064977992;5698.1452782083015;5706.229658995982;4108.77401742907;4112.383142528644;4114.444549985714;4120.299549076724;4121.835126595022;5984.670843103671;6141.9385806143155;6175.660338681416;6189.3907584027575;6209.875802483834;5861.677607731445;5905.822825315247;5913.645181289136;5923.7926672566255;5957.106434034929;5824.679642619697;5896.823095307148;5941.970290148522;5953.613015154001;5962.731677074456;5799.681017544076;5835.708214589169;5846.41535846429;5860.648361098348;5873.03094989322;5978.880422391441;5983.58114931968;5989.700514974146;5992.43071908168;5999.70001499932;5627.380988091225;5735.680793417454;5746.2529871116485;5775.740091695968;5792.4497172768515 21:49:14 INFO - PID 2300 | |5;yui.html;732.6519903046051;770.5761830992952;772.7256823827541;781.8631739445595;786.8741001439771;12972.675683107915;13788.655283617914;13845.307734613267;15988.76016859748;16384.262708178132;14919.403223871059;15210;15243.009204401706;15382.538523844274;15514.456994005212;886.6497733395289;897.4794619120927;905.800723840754;906.1029580715077;908.9045650206732;912.0423555266976;912.8311262416441;915.0300681277834;915.2357781252662;916.3677062826629;960.9135177833994;964.0985678390692;964.5129209749067;969.8787651543557;971.028971028971;947.4552132523827;951.2152474208806;959.9136077753001;960.812641534901;961.1685891703661;696.9128858892639;696.9616671083088;702.3503259485007;704.1690804850275;707.702764838769;13728.313584320844;13866.722665546733;13975.860241397557;13986.30068496571;14638.853611463963;15046.849531504655;15212.923935380362;15398.846011539854;15474.30365633538;15654.139022353766;11877.16859819813;11887.88112118885;12109.6367108986;12155.513779448811;12312.569060082855;2928.3996780660127;2932.8533573321247;2948.7493563047165;2962.2002059444044;2963.7184467475554;72226.27773722248;72232.63883680548;72671.63664181698;72909.6354518224;74995;12463.5014599415;12604.621861344174;12759.29823859678;12782.488700452064;12846.935765321301;22365.664515032287;23173.7682623175;23491.295261142193;23520.294391168292;23546.882265588905;5753.194552762617;5836.153757705109;5922.289325280908;5922.851928701817;5924.407559244128;2995.0415866922376;3044.588980487606;3054.1906394805396;3056.679048699899;3060.5715199872034;3188.28263640679;3245.7503861013206;3249.805011699258;3266.624338201137;3282.786618869766;684.6953105867841;689.6344937183301;690.5097380859646;691.2327316678483;694.6630884021347;601.7202001069523;605.7607245138146;609.5458883132095;611.7247238742584;622.890994076044;9629.759256018655;9865.309428340091;10054;10181.33821301613;10509.474526273656;596.2040675697991;596.8895754285471;600.2586805295457;602.5330368964001;602.6354055796268;4363.432753741993;4507.526709695435;4514.210013247734;4515.300128480091;4520.299353600197;62393.68803156046;63047.36952630507;63658.68170659117;66532.66733666397;66988;56624.716876415354;57448.42551574514;58000.419995800345;58111.70944145337;58665.706671467226;50521.49478505241;51349.74325128351;51672;51741.22388164105;54440.72779636076;9049.230815380766;9115.22520585731;9139.497327646777;9166.129217724305;9175.77060573491;26732.599011014463;26755.33111672224;26895;28062.85968570144;28530.286742830765;32672.183195419355;32776.83611581927;45274.54725452703;45478.54521454876;46616.30075548937;13099;13323.13399629021;13347.532836351069;13354.599362019155;13381.866181338062;14555.92722036383;14691.191984440959;15157.696846063238;15311.77032344538;15671.68656626884;14093.436262549383;14280.500182493563;14581.489647862274;14614.19621920762;14981.176035318162;13345.466181353026;14025.438982440588;14223.502177423741;14337.78493322622;14403.711925761636;13096.083274170716;13240.20558766477;13255.337233138498;13350;13542.390592423562;10071.84892226632;10274.897251027693;10280.794384112425;10348.17837975223;10833.187510936868;9826.263030272616;9841.114299713061;10052.54763535628;10288.228382871164;10378.481075946323 21:49:14 INFO - PID 2300 | __end_tp_report 21:49:14 INFO - PID 2300 | __start_cc_report 21:49:14 INFO - PID 2300 | _x_x_mozilla_cycle_collect,341 21:49:14 INFO - PID 2300 | __end_cc_report 21:49:14 INFO - PID 2300 | __startTimestamp1493873354762__endTimestamp 21:49:14 INFO - PID 2300 | 21:49:14 INFO - PID 2300 | ------- Summary: start ------- 21:49:14 INFO - PID 2300 | Number of tests: 6 21:49:14 INFO - PID 2300 | 21:49:14 INFO - PID 2300 | [#0] dojo.html Cycles:165 Average:5243.00 Median:5397.43 stddev:626.53 (11.6%) stddev-sans-first:597.39 21:49:14 INFO - PID 2300 | Values: 2759.6 2775.2 2799.3 2806.6 2817.3 5220.3 5326.0 5346.2 5372.0 5392.8 5278.7 5279.6 5330.4 5407.5 5428.9 4721.2 4735.6 4737.2 4757.2 4770.7 4777.0 4817.3 4823.9 4832.8 4844.9 4517.9 4629.9 4648.0 4761.5 4770.2 4667.0 4675.6 4691.7 4731.4 4742.7 4608.4 4628.9 4656.1 4662.7 4684.8 5079.6 5114.2 5145.8 5162.8 5181.3 5759.1 5764.0 5780.4 5781.5 5827.2 5753.7 5778.5 5786.1 5794.0 5810.4 5240.5 5335.9 5338.4 5354.6 5359.1 5826.3 5842.2 5851.2 5867.4 5873.7 5594.5 5619.8 5716.0 5716.6 5721.4 5748.3 5823.7 5826.0 5831.6 5863.4 5700.6 5722.2 5729.8 5731.7 5746.6 5694.1 5722.4 5724.2 5729.4 5740.6 4590.2 4667.0 4669.6 4675.7 4689.9 4114.9 4126.8 4135.2 4138.1 4140.5 4885.9 4898.3 4908.8 4909.6 4918.8 5763.4 5768.5 5775.9 5780.4 5795.4 4748.6 4858.7 4868.6 4911.3 4920.8 5086.7 5093.1 5112.3 5149.2 5154.7 5314.0 5324.7 5345.5 5358.2 5392.7 5581.5 5688.6 5723.4 5732.1 5734.0 5352.2 5371.1 5378.3 5397.4 5403.7 5558.8 5598.7 5607.7 5719.8 5741.7 5846.7 5856.9 5864.7 5871.8 5888.4 5497.3 5581.3 5608.6 5626.3 5656.6 5419.2 5437.1 5595.0 5602.9 5609.7 5477.2 5563.4 5592.6 5592.9 5617.9 5627.2 5629.3 5633.4 5639.2 5642.2 5300.6 5453.5 5462.7 5462.9 5509.8 21:49:14 INFO - PID 2300 | 21:49:14 INFO - PID 2300 | [#1] ext.html Cycles:180 Average:30982.22 Median:3109.87 stddev:42136.26 (1354.9%) stddev-sans-first:42193.07 21:49:14 INFO - PID 2300 | Values: 690.6 738.3 754.0 1052.6 1071.2 31314.7 32112.2 32191.2 32246.0 32271.8 33662.2 33828.8 34003.7 34018.5 34129.8 6745.9 6864.2 6957.3 6980.2 6983.4 6938.5 6964.1 7050.7 7052.1 7052.9 7001.5 7003.7 7030.8 7039.9 7041.5 6922.3 6967.0 6974.2 7010.3 7018.1 6816.7 6878.8 6919.6 6919.9 6934.3 30843.1 31056.4 31121.5 31142.4 31152.0 3076.6 3088.8 3109.7 3110.0 3117.2 23930.5 24001.3 24066.0 24118.3 24121.0 3166.1 3194.4 3202.6 3205.2 3210.2 138968.0 139952.0 151288.4 156860.0 157141.0 39198.8 39270.0 39562.4 39665.4 39726.4 41283.6 41314.6 41469.8 41510.0 41577.6 12647.9 12693.9 12710.1 12724.2 12807.0 10152.8 10176.2 10213.4 10275.9 10276.6 12589.7 12710.2 12788.0 12792.1 12882.5 5282.8 5423.4 5476.5 5507.7 5524.1 882.2 908.3 935.1 953.8 960.9 20981.2 21187.4 21239.6 21316.8 21539.8 967.6 1006.3 1015.9 1018.9 1033.3 10474.1 11220.0 11313.1 11342.8 11391.4 180064.0 181358.0 181452.0 182089.0 182097.0 39656.0 40351.2 40355.2 40370.6 40588.6 1261.3 1301.1 1303.8 1304.7 1305.6 19316.8 19850.0 20227.9 20364.3 20573.8 29029.9 29401.3 29469.7 29471.3 29472.4 156890.2 157958.2 158658.0 158695.0 158734.0 27821.4 28349.0 28719.7 29410.6 29980.3 34740.0 35091.6 35205.8 35352.0 35758.8 26954.7 27331.9 27591.3 27787.4 28073.3 26937.6 27156.9 27738.3 28468.1 29284.9 33308.3 33681.8 34343.3 34861.5 34982.1 32352.5 34329.3 35997.5 36180.8 36204.0 25875.6 27720.3 28152.7 28331.6 28436.3 21:49:14 INFO - PID 2300 | 21:49:14 INFO - PID 2300 | [#2] jquery.html Cycles:180 Average:24910.62 Median:382144.00 stddev:63409.77 (16.6%) stddev-sans-first:63560.99 21:49:14 INFO - PID 2300 | Values: 419.9 421.6 422.1 430.9 451.3 17363.9 17482.8 17530.4 17984.6 18076.5 18073.9 18165.0 18857.8 18936.3 19022.0 5456.0 5499.3 5567.1 5594.5 5608.9 5003.3 5062.5 5505.1 5605.2 5642.3 5342.6 5542.0 5562.6 5566.7 5569.2 5544.6 5548.4 5596.0 5596.7 5596.9 4841.4 4941.3 4961.8 4978.8 4991.2 21840.7 21969.8 21981.7 22010.7 22301.8 1553.5 1597.4 1599.9 1626.2 1629.3 14419.2 14501.6 14642.3 14933.6 14955.1 2079.6 2096.7 2123.0 2125.4 2181.5 84881.6 85793.6 85924.6 87423.6 88019.6 10922.2 11151.7 11177.0 11282.9 11396.8 15576.8 15688.2 15689.8 15712.1 15733.7 7363.4 7603.4 7630.8 7924.2 7942.1 7110.4 7211.2 7297.3 7348.8 7353.7 6935.8 7048.2 7087.8 7120.4 7176.9 2020.8 2039.1 2043.0 2046.8 2225.0 870.1 902.3 904.7 913.5 937.1 16677.6 16816.7 17568.5 17698.0 17843.6 897.8 907.8 915.7 924.6 928.8 9159.9 9485.6 9702.5 9804.5 9862.9 380704.4 381792.0 382496.0 384097.0 388101.0 67580.0 67795.3 68812.0 68824.3 69543.3 1048.8 1074.9 1103.9 1113.1 1121.3 14795.3 15066.5 15102.2 15244.7 15768.0 37300.4 37304.4 37404.8 37685.4 38540.8 46030.8 46696.8 46851.8 46933.0 48148.5 7978.0 8191.3 8197.7 8285.0 8410.7 12204.9 12741.7 12896.2 13003.7 13105.1 10892.8 11087.7 11253.0 11325.5 11334.2 10158.3 10761.2 10761.5 10767.5 10972.7 10677.3 10838.9 11006.8 11089.7 11556.2 8348.8 8451.3 8509.2 8514.9 8641.6 11029.4 11144.6 11225.4 11630.2 11678.9 21:49:14 INFO - PID 2300 | 21:49:14 INFO - PID 2300 | [#3] mootools.html Cycles:180 Average:6160.71 Median:4747.99 stddev:3970.39 (83.6%) stddev-sans-first:3964.45 21:49:14 INFO - PID 2300 | Values: 1259.6 1294.4 1316.2 1316.9 1322.4 9402.1 9614.5 9642.9 10054.3 10090.2 9599.6 9765.5 9779.8 9800.4 9814.1 2158.0 2188.9 2189.1 2195.9 2197.6 2079.6 2125.6 2132.8 2134.1 2135.9 2144.7 2157.7 2185.1 2185.9 2198.0 2070.4 2097.7 2105.9 2108.0 2120.7 2017.2 2074.1 2123.2 2127.0 2154.9 9801.3 9808.5 9840.5 9867.0 9896.6 5377.5 5545.6 5549.5 5552.5 5562.4 3101.4 3298.0 3313.2 3330.0 3369.4 1064.8 1082.2 1103.1 1111.5 1119.0 14810.1 14886.5 14952.9 14994.3 15037.5 4434.5 4494.5 4678.1 4715.0 4781.0 10603.7 10626.1 10647.3 10651.5 10669.8 5461.7 5461.8 5479.8 5483.8 5489.0 4876.8 4988.2 5052.6 5103.8 5125.4 3696.1 3797.5 3813.3 3841.3 4035.2 1080.4 1097.1 1105.6 1113.5 1116.8 690.1 724.1 731.6 740.8 744.8 5384.0 5398.4 5477.3 5528.7 5555.9 522.3 537.6 541.1 543.9 548.4 3501.6 3671.7 3679.0 3761.5 3843.8 12430.0 13303.3 13373.9 13416.9 13424.2 13082.5 13252.6 13265.5 13274.4 13275.2 7214.2 7534.2 7586.8 7617.4 7627.0 5375.9 5452.5 5512.6 5573.7 5694.7 11230.8 11294.7 11329.1 11406.4 11461.5 11920.5 11946.6 11955.3 11989.0 12223.9 7277.6 7957.2 8423.3 8479.1 8512.5 9216.1 9260.1 9261.3 9298.0 9303.2 7846.0 7981.3 8108.9 8181.6 8251.3 7774.7 7828.5 7842.6 7850.5 7957.5 7368.7 7453.6 7478.7 7500.6 7509.1 5159.9 5351.5 5412.0 5592.7 5670.4 5356.9 5416.9 5425.6 5430.4 5640.7 21:49:14 INFO - PID 2300 | 21:49:14 INFO - PID 2300 | [#4] prototype.html Cycles:180 Average:4850.65 Median:5581.34 stddev:1447.10 (25.9%) stddev-sans-first:1411.62 21:49:14 INFO - PID 2300 | Values: 374.1 395.1 399.9 400.2 408.8 5433.2 5583.5 5636.7 5706.5 5706.9 5391.3 5530.5 5563.4 5579.2 5618.9 4398.9 4408.4 4411.3 4415.4 4418.0 4058.2 4202.4 4231.2 4406.9 4418.4 4158.7 4164.2 4166.6 4170.5 4170.6 4174.8 4177.0 4181.8 4187.4 4194.7 3520.2 3603.1 3618.7 3647.7 3665.8 5332.4 5338.1 5346.0 5349.8 5397.5 4887.5 4891.5 4894.4 4896.5 4901.6 5718.4 5822.7 5864.1 5882.3 5889.9 4039.6 4042.6 4052.3 4061.5 4062.9 6035.7 6168.0 6227.9 6245.8 6264.8 4094.2 4118.3 4135.6 4136.6 4147.0 4188.2 4196.4 4200.3 4201.0 4201.4 4753.6 4816.7 4885.1 4895.8 4896.5 5877.3 5878.7 5901.8 5907.2 5920.6 1438.3 1456.0 1458.3 1460.6 1461.1 957.4 966.1 972.4 980.6 983.3 5112.9 5114.8 5137.9 5144.4 5180.2 6149.5 6153.2 6164.5 6190.1 6193.3 5002.5 5099.3 5131.4 5136.7 5144.6 3222.1 3255.7 3266.8 3267.2 3272.1 5516.9 5667.8 5668.8 5676.8 5689.9 6243.2 6262.8 6269.7 6291.7 6301.7 5618.9 5630.2 5641.7 5644.4 5656.0 5999.3 6087.9 6107.1 6108.7 6147.6 5852.4 5981.3 5996.5 6014.7 6021.6 5656.5 5664.5 5696.9 5698.1 5706.2 4108.8 4112.4 4114.4 4120.3 4121.8 5984.7 6141.9 6175.7 6189.4 6209.9 5861.7 5905.8 5913.6 5923.8 5957.1 5824.7 5896.8 5942.0 5953.6 5962.7 5799.7 5835.7 5846.4 5860.6 5873.0 5978.9 5983.6 5989.7 5992.4 5999.7 5627.4 5735.7 5746.3 5775.7 5792.4 21:49:14 INFO - PID 2300 | 21:49:14 INFO - PID 2300 | [#5] yui.html Cycles:180 Average:15527.80 Median:32724.51 stddev:18680.24 (57.1%) stddev-sans-first:18699.60 21:49:14 INFO - PID 2300 | Values: 732.7 770.6 772.7 781.9 786.9 12972.7 13788.7 13845.3 15988.8 16384.3 14919.4 15210.0 15243.0 15382.5 15514.5 886.6 897.5 905.8 906.1 908.9 912.0 912.8 915.0 915.2 916.4 960.9 964.1 964.5 969.9 971.0 947.5 951.2 959.9 960.8 961.2 696.9 697.0 702.4 704.2 707.7 13728.3 13866.7 13975.9 13986.3 14638.9 15046.8 15212.9 15398.8 15474.3 15654.1 11877.2 11887.9 12109.6 12155.5 12312.6 2928.4 2932.9 2948.7 2962.2 2963.7 72226.3 72232.6 72671.6 72909.6 74995.0 12463.5 12604.6 12759.3 12782.5 12846.9 22365.7 23173.8 23491.3 23520.3 23546.9 5753.2 5836.2 5922.3 5922.9 5924.4 2995.0 3044.6 3054.2 3056.7 3060.6 3188.3 3245.8 3249.8 3266.6 3282.8 684.7 689.6 690.5 691.2 694.7 601.7 605.8 609.5 611.7 622.9 9629.8 9865.3 10054.0 10181.3 10509.5 596.2 596.9 600.3 602.5 602.6 4363.4 4507.5 4514.2 4515.3 4520.3 62393.7 63047.4 63658.7 66532.7 66988.0 56624.7 57448.4 58000.4 58111.7 58665.7 50521.5 51349.7 51672.0 51741.2 54440.7 9049.2 9115.2 9139.5 9166.1 9175.8 26732.6 26755.3 26895.0 28062.9 28530.3 32672.2 32776.8 45274.5 45478.5 46616.3 13099.0 13323.1 13347.5 13354.6 13381.9 14555.9 14691.2 15157.7 15311.8 15671.7 14093.4 14280.5 14581.5 14614.2 14981.2 13345.5 14025.4 14223.5 14337.8 14403.7 13096.1 13240.2 13255.3 13350.0 13542.4 10071.8 10274.9 10280.8 10348.2 10833.2 9826.3 9841.1 10052.5 10288.2 10378.5 21:49:14 INFO - PID 2300 | -------- Summary: end -------- 21:49:14 INFO - PID 2300 | 21:49:15 INFO - TEST-INFO | 2300: exit 0 21:49:15 INFO - TEST-OK | dromaeo_css | took 1119962ms 21:49:15 INFO - TEST-START | kraken 21:49:15 INFO - operating with platform_type : linux_ 21:49:15 INFO - Initialising browser for kraken test... 21:49:15 INFO - TEST-INFO | started process 2928 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG1AXjW/profile http://localhost:55107/getInfo.html) 21:49:19 INFO - PID 2928 | __metrics Screen width/height:1600/1200 21:49:19 INFO - PID 2928 | colorDepth:24 21:49:19 INFO - PID 2928 | Browser inner width/height: 1024/695 21:49:19 INFO - PID 2928 | __metrics 21:49:21 INFO - TEST-INFO | 2928: exit 0 21:49:21 INFO - Browser initialized. 21:49:21 INFO - Running cycle 1/1 for kraken test... 21:49:22 INFO - TEST-INFO | started process 3131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG1AXjW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:49:34 INFO - PID 3131 | RSS: Main: 175202304 21:49:34 INFO - PID 3131 | 21:49:36 INFO - PID 3131 | Cycle 1(1): loaded http://localhost:55107/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55107/tests/kraken/driver.html?testName=audio-beat-detection) 21:49:37 INFO - PID 3131 | RSS: Main: 183296000 21:49:37 INFO - PID 3131 | 21:49:40 INFO - PID 3131 | Cycle 1(1): loaded http://localhost:55107/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55107/tests/kraken/driver.html?testName=audio-dft) 21:49:40 INFO - PID 3131 | RSS: Main: 182337536 21:49:40 INFO - PID 3131 | 21:49:43 INFO - PID 3131 | Cycle 1(1): loaded http://localhost:55107/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55107/tests/kraken/driver.html?testName=audio-fft) 21:49:44 INFO - PID 3131 | RSS: Main: 178753536 21:49:44 INFO - PID 3131 | 21:49:46 INFO - PID 3131 | Cycle 1(1): loaded http://localhost:55107/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55107/tests/kraken/driver.html?testName=audio-oscillator) 21:49:47 INFO - PID 3131 | RSS: Main: 179671040 21:49:47 INFO - PID 3131 | 21:49:49 INFO - PID 3131 | Cycle 1(1): loaded http://localhost:55107/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55107/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:49:50 INFO - PID 3131 | RSS: Main: 179744768 21:49:50 INFO - PID 3131 | 21:49:53 INFO - PID 3131 | Cycle 1(1): loaded http://localhost:55107/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55107/tests/kraken/driver.html?testName=imaging-darkroom) 21:49:53 INFO - PID 3131 | RSS: Main: 183533568 21:49:53 INFO - PID 3131 | 21:49:57 INFO - PID 3131 | Cycle 1(1): loaded http://localhost:55107/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55107/tests/kraken/driver.html?testName=imaging-desaturate) 21:49:57 INFO - PID 3131 | RSS: Main: 181006336 21:49:57 INFO - PID 3131 | 21:50:00 INFO - PID 3131 | Cycle 1(1): loaded http://localhost:55107/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55107/tests/kraken/driver.html?testName=json-parse-financial) 21:50:01 INFO - PID 3131 | RSS: Main: 182046720 21:50:01 INFO - PID 3131 | 21:50:03 INFO - PID 3131 | Cycle 1(1): loaded http://localhost:55107/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55107/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:50:03 INFO - PID 3131 | RSS: Main: 183193600 21:50:03 INFO - PID 3131 | 21:50:05 INFO - PID 3131 | Cycle 1(1): loaded http://localhost:55107/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55107/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:50:06 INFO - PID 3131 | RSS: Main: 184045568 21:50:06 INFO - PID 3131 | 21:50:08 INFO - PID 3131 | Cycle 1(1): loaded http://localhost:55107/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55107/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:50:08 INFO - PID 3131 | RSS: Main: 183664640 21:50:08 INFO - PID 3131 | 21:50:11 INFO - PID 3131 | Cycle 1(1): loaded http://localhost:55107/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55107/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:50:12 INFO - PID 3131 | RSS: Main: 183062528 21:50:12 INFO - PID 3131 | 21:50:15 INFO - PID 3131 | Cycle 1(1): loaded http://localhost:55107/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55107/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:50:16 INFO - PID 3131 | RSS: Main: 183336960 21:50:16 INFO - PID 3131 | 21:50:18 INFO - PID 3131 | Cycle 1(1): loaded http://localhost:55107/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55107/tests/kraken/driver.html?testName=ai-astar) 21:50:18 INFO - PID 3131 | RSS: Main: 185368576 21:50:18 INFO - PID 3131 | 21:50:18 INFO - PID 3131 | __start_tp_report 21:50:18 INFO - PID 3131 | _x_x_mozilla_page_load 21:50:18 INFO - PID 3131 | _x_x_mozilla_page_load_details 21:50:18 INFO - PID 3131 | |i|pagename|runs| 21:50:18 INFO - PID 3131 | |0;ai-astar;104;112;112;113;113;115;113;111;112;111 21:50:18 INFO - PID 3131 | |1;audio-beat-detection;152;125;125;161;121;125;126;125;146;124 21:50:18 INFO - PID 3131 | |2;audio-dft;163;164;163;165;169;174;166;165;166;164 21:50:18 INFO - PID 3131 | |3;audio-fft;74;75;75;105;74;75;76;75;95;76 21:50:18 INFO - PID 3131 | |4;audio-oscillator;84;84;105;84;84;82;96;83;83;101 21:50:18 INFO - PID 3131 | |5;imaging-gaussian-blur;118;118;114;114;114;113;114;117;115;114 21:50:18 INFO - PID 3131 | |6;imaging-darkroom;150;150;151;149;151;153;150;151;150;150 21:50:18 INFO - PID 3131 | |7;imaging-desaturate;95;94;94;94;99;95;95;95;96;94 21:50:18 INFO - PID 3131 | |8;json-parse-financial;54;56;56;54;56;55;59;56;55;54 21:50:18 INFO - PID 3131 | |9;json-stringify-tinderbox;55;54;54;55;56;55;54;55;55;55 21:50:18 INFO - PID 3131 | |10;stanford-crypto-aes;89;81;82;82;84;80;82;89;80;80 21:50:18 INFO - PID 3131 | |11;stanford-crypto-ccm;132;138;131;130;131;130;132;142;181;146 21:50:18 INFO - PID 3131 | |12;stanford-crypto-pbkdf2;192;190;191;181;191;191;190;191;196;191 21:50:18 INFO - PID 3131 | |13;stanford-crypto-sha256-iterative;76;71;71;71;71;77;72;74;74;70 21:50:18 INFO - PID 3131 | __end_tp_report 21:50:18 INFO - PID 3131 | __start_cc_report 21:50:18 INFO - PID 3131 | _x_x_mozilla_cycle_collect,830 21:50:18 INFO - PID 3131 | __end_cc_report 21:50:18 INFO - PID 3131 | __startTimestamp1493873418282__endTimestamp 21:50:18 INFO - PID 3131 | 21:50:18 INFO - PID 3131 | ------- Summary: start ------- 21:50:18 INFO - PID 3131 | Number of tests: 14 21:50:18 INFO - PID 3131 | 21:50:18 INFO - PID 3131 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.50 stddev:2.91 (2.6%) stddev-sans-first:1.24 21:50:18 INFO - PID 3131 | Values: 104.0 112.0 112.0 113.0 113.0 115.0 113.0 111.0 112.0 111.0 21:50:18 INFO - PID 3131 | 21:50:18 INFO - PID 3131 | [#1] audio-beat-detection Cycles:10 Average:133.00 Median:125.50 stddev:14.31 (11.4%) stddev-sans-first:13.43 21:50:18 INFO - PID 3131 | Values: 152.0 125.0 125.0 161.0 121.0 125.0 126.0 125.0 146.0 124.0 21:50:18 INFO - PID 3131 | 21:50:18 INFO - PID 3131 | [#2] audio-dft Cycles:10 Average:165.90 Median:165.50 stddev:3.35 (2.0%) stddev-sans-first:3.38 21:50:18 INFO - PID 3131 | Values: 163.0 164.0 163.0 165.0 169.0 174.0 166.0 165.0 166.0 164.0 21:50:18 INFO - PID 3131 | 21:50:18 INFO - PID 3131 | [#3] audio-fft Cycles:10 Average:80.00 Median:75.00 stddev:10.82 (14.4%) stddev-sans-first:11.26 21:50:18 INFO - PID 3131 | Values: 74.0 75.0 75.0 105.0 74.0 75.0 76.0 75.0 95.0 76.0 21:50:18 INFO - PID 3131 | 21:50:18 INFO - PID 3131 | [#4] audio-oscillator Cycles:10 Average:88.60 Median:84.00 stddev:8.62 (10.3%) stddev-sans-first:8.98 21:50:18 INFO - PID 3131 | Values: 84.0 84.0 105.0 84.0 84.0 82.0 96.0 83.0 83.0 101.0 21:50:18 INFO - PID 3131 | 21:50:18 INFO - PID 3131 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:114.50 stddev:1.85 (1.6%) stddev-sans-first:1.64 21:50:18 INFO - PID 3131 | Values: 118.0 118.0 114.0 114.0 114.0 113.0 114.0 117.0 115.0 114.0 21:50:18 INFO - PID 3131 | 21:50:18 INFO - PID 3131 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 21:50:18 INFO - PID 3131 | Values: 150.0 150.0 151.0 149.0 151.0 153.0 150.0 151.0 150.0 150.0 21:50:18 INFO - PID 3131 | 21:50:18 INFO - PID 3131 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:1.52 (1.6%) stddev-sans-first:1.62 21:50:18 INFO - PID 3131 | Values: 95.0 94.0 94.0 94.0 99.0 95.0 95.0 95.0 96.0 94.0 21:50:18 INFO - PID 3131 | 21:50:18 INFO - PID 3131 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:1.51 (2.7%) stddev-sans-first:1.50 21:50:18 INFO - PID 3131 | Values: 54.0 56.0 56.0 54.0 56.0 55.0 59.0 56.0 55.0 54.0 21:50:18 INFO - PID 3131 | 21:50:18 INFO - PID 3131 | [#9] json-stringify-tinderbox Cycles:10 Average:54.80 Median:55.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 21:50:18 INFO - PID 3131 | Values: 55.0 54.0 54.0 55.0 56.0 55.0 54.0 55.0 55.0 55.0 21:50:18 INFO - PID 3131 | 21:50:18 INFO - PID 3131 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.00 stddev:3.45 (4.2%) stddev-sans-first:2.86 21:50:18 INFO - PID 3131 | Values: 89.0 81.0 82.0 82.0 84.0 80.0 82.0 89.0 80.0 80.0 21:50:18 INFO - PID 3131 | 21:50:18 INFO - PID 3131 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:135.00 stddev:15.67 (11.6%) stddev-sans-first:16.40 21:50:18 INFO - PID 3131 | Values: 132.0 138.0 131.0 130.0 131.0 130.0 132.0 142.0 181.0 146.0 21:50:18 INFO - PID 3131 | 21:50:18 INFO - PID 3131 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.40 Median:191.00 stddev:3.72 (1.9%) stddev-sans-first:3.90 21:50:18 INFO - PID 3131 | Values: 192.0 190.0 191.0 181.0 191.0 191.0 190.0 191.0 196.0 191.0 21:50:18 INFO - PID 3131 | 21:50:18 INFO - PID 3131 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:73.00 stddev:2.41 (3.3%) stddev-sans-first:2.24 21:50:18 INFO - PID 3131 | Values: 76.0 71.0 71.0 71.0 71.0 77.0 72.0 74.0 74.0 70.0 21:50:18 INFO - PID 3131 | -------- Summary: end -------- 21:50:18 INFO - PID 3131 | 21:50:19 INFO - TEST-INFO | 3131: exit 0 21:50:19 INFO - TEST-OK | kraken | took 63993ms 21:50:19 INFO - SUITE-END | took 1183s 21:50:19 INFO - Completed test suite (00:19:44) 21:50:19 INFO - javascript benchmark 21:50:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6746.2758370607435, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2759.62745029421, 2775.2229375774764, 2799.300174956261, 2806.593044008619, 2817.323842277854, 5220.321358223426, 5326.0, 5346.2247974043785, 5372.0330340538685, 5392.838214853556, 5278.736063196844, 5279.63042587019, 5330.387005494369, 5407.540359069474, 5428.9185662214995, 4721.220998535237, 4735.550122738335, 4737.218358970775, 4757.215059515176, 4770.713757174563, 4777.0, 4817.325574419584, 4823.927641085369, 4832.830850920219, 4844.90989527357, 4517.932231016537, 4629.907401851944, 4648.047150334173, 4761.523847615211, 4770.236762118079, 4667.043256132485, 4675.602573781232, 4691.671582989192, 4731.408573928259, 4742.668013239075, 4608.446986361658, 4628.884277893046, 4656.115338085753, 4662.72023678577, 4684.8360307389075, 5079.644424890259, 5114.181730923072, 5145.845624631267, 5162.767675454614, 5181.274621552986, 5759.136129580555, 5764.0, 5780.439281394042, 5781.508571771405, 5827.242458480413, 5753.741081651294, 5778.5377169826315, 5786.132080188006, 5794.0, 5810.418958104198, 5240.475952404805, 5335.86660333487, 5338.439463856317, 5354.571634269288, 5359.088954877602, 5826.329972053183, 5842.211301474332, 5851.239338885917, 5867.354590994987, 5873.706314684248, 5594.524465420485, 5619.775208991677, 5716.028275193227, 5716.571257155647, 5721.39925307845, 5748.281464816898, 5823.650580965155, 5825.970870145622, 5831.562632802472, 5863.442972917566, 5700.572457065737, 5722.198892155102, 5729.770809167587, 5731.656100633975, 5746.5977381583725, 5694.06048002075, 5722.399148089474, 5724.16999535065, 5729.398413166641, 5740.598158128891, 4590.219662657356, 4667.019925815549, 4669.626429885601, 4675.742834144086, 4689.859304220879, 4114.938275925863, 4126.814293356806, 4135.234981528367, 4138.13099249155, 4140.503139623264, 4885.926711099336, 4898.314236006961, 4908.754562271872, 4909.582685471703, 4918.754062296871, 5763.423657634203, 5768.451997060272, 5775.8556036099435, 5780.410387143569, 5795.449432303924, 4748.596369308579, 4858.684185527929, 4868.634852386085, 4911.336969509142, 4920.827771027997, 5086.720230387365, 5093.057784309841, 5112.258722485219, 5149.227615857576, 5154.664946778447, 5313.973430132824, 5324.680519168863, 5345.518903298722, 5358.19627055937, 5392.730363481889, 5581.469760372758, 5688.63023903445, 5723.370429252862, 5732.111522713986, 5733.9713301434895, 5352.170413585901, 5371.0869152244995, 5378.300820893259, 5397.433269506802, 5403.675779453245, 5558.805441809679, 5598.664080155204, 5607.691576963306, 5719.771209151588, 5741.684207368635, 5846.736896839568, 5856.9121463178935, 5864.706764661664, 5871.794487192928, 5888.411158884077, 5497.312835895513, 5581.302337207849, 5608.6073974823, 5626.32484101894, 5656.575756818337, 5419.214213939035, 5437.075697131576, 5595.0, 5602.915956260578, 5609.747561359667, 5477.178423236546, 5563.415841336763, 5592.608517403743, 5592.916106258491, 5617.915731264116, 5627.212190293444, 5629.296337957755, 5633.380328163817, 5639.238702775073, 5642.153676948491, 5300.602454815981, 5453.454654534674, 5462.6995515247045, 5462.91805622908, 5509.752061157177], "value": 5197.274744424116, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.6374153569376, 738.2801768275931, 753.9736109236176, 1052.5684469367561, 1071.2073065931213, 31314.68685313149, 32112.197195070134, 32191.19522011951, 32246.0, 32271.838640806793, 33662.15844603886, 33828.830855845685, 34003.65996340036, 34018.53647806915, 34129.82935085327, 6745.865082698343, 6864.176298844146, 6957.304269573053, 6980.232174460805, 6983.406410455117, 6938.479614028943, 6964.059851919977, 7050.6827192776445, 7052.083229180199, 7052.858942821141, 7001.544899581511, 7003.684834182474, 7030.753923612675, 7039.894401583981, 7041.471889608274, 6922.342377474132, 6967.024616553712, 6974.197967233782, 7010.298970103, 7018.052562903994, 6816.727330906758, 6878.793636190922, 6919.550229235084, 6919.8962015569805, 6934.341237582422, 30843.074707758802, 31056.378872422425, 31121.533177002362, 31142.37715245705, 31152.0, 3076.5692803007596, 3088.8455577221275, 3109.70457806508, 3110.0358888744563, 3117.2051126962706, 23930.521389572285, 24001.27996160118, 24066.0, 24118.276451706475, 24121.035158593637, 3166.0501849445072, 3194.4409728297455, 3202.551642770014, 3205.1506350817053, 3210.1653570071717, 138968.0, 139952.0, 151288.43557822064, 156860.0, 157141.0, 39198.804005979786, 39270.0, 39562.40656390157, 39665.40501892474, 39726.40410393846, 41283.587164127974, 41314.586854131674, 41469.81627296588, 41510.0, 41577.584224157974, 12647.873521264853, 12693.873061269454, 12710.110292279453, 12724.1729287596, 12807.0, 10152.796944061078, 10176.18590512772, 10213.38719676807, 10275.948620256851, 10276.640317588848, 12589.685257868627, 12710.173838700455, 12788.0, 12792.081187821901, 12882.549110781078, 5282.841514754564, 5423.423873660059, 5476.479734425223, 5507.7246137692955, 5524.14375771756, 882.2148288023536, 908.2506931781174, 935.1069728409353, 953.7710949372239, 960.8606752021058, 20981.16075356999, 21187.36437906865, 21239.575208495742, 21316.77983313757, 21539.78460215409, 967.5597603090717, 1006.2503434941016, 1015.9238057145743, 1018.9286749927434, 1033.2715435617872, 10474.109700675528, 11220.046296064926, 11313.094952403788, 11342.773144537063, 11391.373474458818, 180064.0, 181358.0, 181452.0, 182089.0, 182097.0, 39656.0, 40351.192976140315, 40355.19289614191, 40370.59629403727, 40588.594114058484, 1261.2873726344585, 1301.1152416356779, 1303.758804621148, 1304.7260075384086, 1305.5691621764795, 19316.806831931503, 19850.0, 20227.898860505604, 20364.28724994618, 20573.794262057785, 29029.854850725613, 29401.264968375108, 29469.705302946695, 29471.26321841971, 29472.41055178927, 156890.21554892152, 157958.2102089482, 158658.0, 158695.0, 158734.0, 27821.44357112806, 28349.0, 28719.71280287254, 29410.55884161782, 29980.250493737833, 34740.0, 35091.64908350884, 35205.82397088101, 35352.0, 35758.8212058938, 26954.73045269522, 27331.863340683965, 27591.31021724473, 27787.44425111527, 28073.298167545974, 26937.595936061367, 27156.864215678794, 27738.306542336602, 28468.145955621363, 29284.853575731984, 33308.333833322715, 33681.83159084189, 34343.31313373768, 34861.47707784436, 34982.12544686403, 32352.514712278862, 34329.313413731084, 35997.46003809998, 36180.81909590435, 36204.0, 25875.61186582165, 27720.306992324546, 28152.718472815828, 28331.575026375034, 28436.303280574222], "value": 14775.452951868372, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.8824329187827, 421.6057985783291, 422.13251767617555, 430.9461317335333, 451.31850905133257, 17363.913180434098, 17482.825171748278, 17530.44422153412, 17984.55038624035, 18076.548086297833, 18073.909630451828, 18165.007396745423, 18857.811421885777, 18936.337228197015, 19022.0, 5456.0, 5499.257600223968, 5567.109262517998, 5594.524465420423, 5608.887822243552, 5003.349564556603, 5062.519060689247, 5505.119180931052, 5605.243292155547, 5642.322921249456, 5342.572594192456, 5541.972290138544, 5562.610617256793, 5566.749496272657, 5569.220309156722, 5544.584156188302, 5548.361938377098, 5596.048671725816, 5596.692181930012, 5596.888062238773, 4841.443234028096, 4941.283513890466, 4961.82633607822, 4978.77595508203, 4991.201407774739, 21840.672389914165, 21969.780302196934, 21981.67027494589, 22010.669839952414, 22301.776982230294, 1553.5494706535092, 1597.3530720058395, 1599.9040057596465, 1626.2437966345587, 1629.3075442936704, 14419.206943618097, 14501.564953051426, 14642.267886605734, 14933.626659333495, 14955.102693838297, 2079.5736873940805, 2096.7379077615296, 2123.0340195211143, 2125.4048866317457, 2181.5091604388886, 84881.57559212226, 85793.57103214506, 85924.57037714834, 87423.56288218581, 88019.55990220008, 10922.235443518877, 11151.665450036511, 11177.0, 11282.943585282184, 11396.772064558663, 15576.766348504781, 15688.215589220494, 15689.764653530206, 15712.13583252932, 15733.68532629341, 7363.374113200331, 7603.391728661693, 7630.847383052308, 7924.167962363868, 7942.12636609984, 7110.360067593838, 7211.170715367695, 7297.270272972766, 7348.77953661391, 7353.70585176587, 6935.826604334932, 7048.224695283515, 7087.822804429828, 7120.35916767483, 7176.856462870714, 2020.777714451409, 2039.082412914165, 2043.038682864437, 2046.8362530997485, 2225.0321110317063, 870.1037930931151, 902.278177458031, 904.6652738486671, 913.4975763330142, 937.1097457415347, 16677.583060423585, 16816.74774878378, 17568.472945811645, 17698.02722312149, 17843.553911152325, 897.7755561109723, 907.832051070554, 915.6612053540233, 924.6440120553635, 928.7724507495572, 9159.90840091604, 9485.573149208301, 9702.466364349888, 9804.46075465842, 9862.852057219148, 380704.4104347452, 381792.0, 382496.0, 384097.0, 388101.0, 67580.0, 67795.32204677988, 68812.0, 68824.31175688279, 69543.3045669547, 1048.7902419516279, 1074.8763892152504, 1103.9282446640943, 1113.059464752283, 1121.265571050963, 14795.334209960361, 15066.472673456376, 15102.244887755787, 15244.695106098037, 15768.0, 37300.44049339208, 37304.44043339298, 37404.81297593495, 37685.434718479795, 38540.80729596334, 46030.769846151896, 46696.766516167205, 46851.765741171075, 46933.0, 48148.518514815805, 7978.0, 8191.262786349257, 8197.71308004217, 8285.047219569826, 8410.705625303084, 12204.87795122073, 12741.681457963625, 12896.16174948663, 13003.674908127372, 13105.14816536922, 10892.82143571273, 11087.667369978913, 11253.0, 11325.546978120783, 11334.206605537533, 10158.288919775545, 10761.246712730033, 10761.46192690378, 10767.515461804394, 10972.670819875417, 10677.305975111592, 10838.945805270923, 11006.834897476705, 11089.722756931142, 11556.191066625255, 8348.833023339621, 8451.32389408858, 8509.234168924826, 8514.914850851412, 8641.611127499153, 11029.393383363991, 11144.60993865211, 11225.4387280634, 11630.244034137753, 11678.941605291919], "value": 8852.49215069582, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1259.6472987563482, 1294.3592921503857, 1316.1576590981767, 1316.891299146662, 1322.4049177869954, 9402.10679985402, 9614.519274036296, 9642.903570964289, 10054.296199266055, 10090.192784577235, 9599.616015359377, 9765.51172441377, 9779.804403911918, 9800.411975281488, 9814.067663571966, 2157.956840863186, 2188.9014994325294, 2189.1134090693295, 2195.9011844467036, 2197.560487902418, 2079.6360636888558, 2125.564259326842, 2132.829373650112, 2134.0716788197105, 2135.882526461052, 2144.7211862457857, 2157.7194964654573, 2185.09318632768, 2185.901634426447, 2198.0, 2070.4409809351464, 2097.664373700208, 2105.8947052647304, 2108.0408414171593, 2120.692499587551, 2017.213286818142, 2074.0770357191054, 2123.1613512662566, 2126.9787302126933, 2154.8707077575395, 9801.264905132144, 9808.509574521246, 9840.507974601242, 9866.950665246699, 9896.55465504054, 5377.46225377463, 5545.584081193886, 5549.528290095347, 5552.472515111058, 5562.443755624446, 3101.379724055198, 3297.950530742041, 3313.1551454378978, 3329.9500507492166, 3369.3766653168996, 1064.8243039898407, 1082.247837752762, 1103.0954617213888, 1111.4998250787178, 1119.043218048565, 14810.111393316436, 14886.478973235884, 14952.850471495254, 14994.250287485582, 15037.473688420961, 4434.534373890695, 4494.4606647202545, 4678.111158879802, 4714.95285047152, 4781.019890922353, 10603.681889543326, 10626.14990800734, 10647.30792498485, 10651.520681569347, 10669.772976107692, 5461.726913654302, 5461.808836690697, 5479.808206712746, 5483.835484935458, 5489.0, 4876.804927802848, 4988.176950803077, 5052.5705315048635, 5103.795848166106, 5125.384953805567, 3696.1129328960856, 3797.487339209227, 3813.3326667833016, 3841.2893614681375, 4035.2131334389514, 1080.3895798873612, 1097.0527314017681, 1105.5577768892508, 1113.4766659669942, 1116.810142275815, 690.102866273852, 724.116577775124, 731.6195578299255, 740.76665850257, 744.8286894014407, 5383.973080134574, 5398.352197736297, 5477.315335583052, 5528.723563821793, 5555.8888822223325, 522.2583930818247, 537.6209772110652, 541.0990700483729, 543.8640339915021, 548.3995025447128, 3501.632328605511, 3671.6511931366476, 3679.0, 3761.5110035695734, 3843.8078096095082, 12430.0, 13303.3348332583, 13373.93313033448, 13416.865831341562, 13424.194548327132, 13082.476700932046, 13252.602421927357, 13265.535706250235, 13274.402651880495, 13275.203487790763, 7214.242504537053, 7534.171241163468, 7586.848263034819, 7617.390608751287, 7627.046619172604, 5375.946240537701, 5452.454754524516, 5512.641678290898, 5573.7213139343685, 5694.686792226467, 11230.764615892082, 11294.717632058935, 11329.093672506344, 11406.372649504357, 11461.48423320936, 11920.52317907274, 11946.641600751991, 11955.282683039046, 11989.0, 12223.877761222275, 7277.563346199245, 7957.1644977276555, 8423.284020858051, 8479.067302596834, 8512.53181075022, 9216.07839216073, 9260.120288572574, 9261.259099272176, 9298.023707510885, 9303.162715355651, 7846.0, 7981.281684648409, 8108.878366824621, 8181.5500147490075, 8251.257386835214, 7774.727884524241, 7828.530288182727, 7842.568658723597, 7850.528968261922, 7957.482763620346, 7368.705251789868, 7453.627318634155, 7478.663460144416, 7500.587467689329, 7509.061367329084, 5159.922601161061, 5351.464853514617, 5411.972940135274, 5592.692401917933, 5670.376258611632, 5356.892862142813, 5416.891662166813, 5425.565954723534, 5430.40265570779, 5640.689762063126], "value": 4606.601915147673, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.12828110502534, 395.06764036872977, 399.9280129576676, 400.2495321272614, 408.79151632667333, 5433.185022246665, 5583.492457036597, 5636.746346414411, 5706.489144776301, 5706.857328566788, 5391.29913111296, 5530.5299049580735, 5563.356001818805, 5579.191017302499, 5618.932402843457, 4398.8900277493, 4408.42690450241, 4411.250087485119, 4415.359772832937, 4417.977910110445, 4058.208649313385, 4202.432671589342, 4231.217224813419, 4406.889827754316, 4418.403515525411, 4158.7296825706235, 4164.167166566684, 4166.604172603597, 4170.47869016373, 4170.624643782059, 4174.791260436966, 4176.987614862162, 4181.811818468176, 4187.371894215861, 4194.748315101104, 3520.2079532105327, 3603.1352475405974, 3618.6924111450558, 3647.7081833453526, 3665.798381089039, 5332.440093790174, 5338.092524270884, 5346.0, 5349.786008559653, 5397.46025397461, 4887.486813884527, 4891.486393928657, 4894.36373271476, 4896.534829191221, 4901.5588597026435, 5718.42019909682, 5822.650640961556, 5864.120381942743, 5882.29412470502, 5889.911651325234, 4039.575844536311, 4042.555318914917, 4052.2705912935658, 4061.4923134608175, 4062.907602584671, 6035.698215089228, 6167.969160154171, 6227.906581401283, 6245.781397651061, 6264.809686159615, 4094.2016306819883, 4118.320477121301, 4135.627793498539, 4136.565660605654, 4147.00471886745, 4188.183304255641, 4196.433481479961, 4200.348945913388, 4201.0, 4201.432806571135, 4753.643476739258, 4816.662833601615, 4885.145099607555, 4895.779689913891, 4896.5103489651465, 5877.324107727581, 5878.706064696748, 5901.822945311647, 5907.232059832194, 5920.5595803147635, 1438.3167995202195, 1455.978160327596, 1458.3145921416917, 1460.6348412896775, 1461.072219140832, 957.4111921168432, 966.1015255812163, 972.3825370889394, 980.5538479991586, 983.2576404814463, 5112.872178195575, 5114.846554603368, 5137.948620513822, 5144.408393034774, 5180.171172612364, 6149.5080393568405, 6153.1693221415435, 6164.537659675542, 6190.133381326618, 6193.349698281706, 5002.52476014778, 5099.260607211933, 5131.409887862869, 5136.717480538607, 5144.588432925357, 3222.113918672384, 3255.674432556773, 3266.7876588022177, 3267.2485328374605, 3272.132884785534, 5516.9448305517235, 5667.801626943037, 5668.773249070074, 5676.829695109153, 5689.9146512802345, 6243.219597550306, 6262.843428914313, 6269.7178626961895, 6291.653959032297, 6301.6534090625455, 5618.943810561924, 5630.18362337467, 5641.661500309912, 5644.379118296984, 5656.0, 5999.3100793407575, 6087.869245763947, 6107.053406721965, 6108.725107370268, 6147.600405973598, 5852.385499522659, 5981.282246130492, 5996.4603185713495, 6014.699265036818, 6021.578489505692, 5656.547476201977, 5664.461876121762, 5696.946064977992, 5698.1452782083015, 5706.229658995982, 4108.77401742907, 4112.383142528644, 4114.444549985714, 4120.299549076724, 4121.835126595022, 5984.670843103671, 6141.9385806143155, 6175.660338681416, 6189.3907584027575, 6209.875802483834, 5861.677607731445, 5905.822825315247, 5913.645181289136, 5923.7926672566255, 5957.106434034929, 5824.679642619697, 5896.823095307148, 5941.970290148522, 5953.613015154001, 5962.731677074456, 5799.681017544076, 5835.708214589169, 5846.41535846429, 5860.648361098348, 5873.03094989322, 5978.880422391441, 5983.58114931968, 5989.700514974146, 5992.43071908168, 5999.70001499932, 5627.380988091225, 5735.680793417454, 5746.2529871116485, 5775.740091695968, 5792.4497172768515], "value": 4404.250331215046, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.6519903046051, 770.5761830992952, 772.7256823827541, 781.8631739445595, 786.8741001439771, 12972.675683107915, 13788.655283617914, 13845.307734613267, 15988.76016859748, 16384.262708178132, 14919.403223871059, 15210.0, 15243.009204401706, 15382.538523844274, 15514.456994005212, 886.6497733395289, 897.4794619120927, 905.800723840754, 906.1029580715077, 908.9045650206732, 912.0423555266976, 912.8311262416441, 915.0300681277834, 915.2357781252662, 916.3677062826629, 960.9135177833994, 964.0985678390692, 964.5129209749067, 969.8787651543557, 971.028971028971, 947.4552132523827, 951.2152474208806, 959.9136077753001, 960.812641534901, 961.1685891703661, 696.9128858892639, 696.9616671083088, 702.3503259485007, 704.1690804850275, 707.702764838769, 13728.313584320844, 13866.722665546733, 13975.860241397557, 13986.30068496571, 14638.853611463963, 15046.849531504655, 15212.923935380362, 15398.846011539854, 15474.30365633538, 15654.139022353766, 11877.16859819813, 11887.88112118885, 12109.6367108986, 12155.513779448811, 12312.569060082855, 2928.3996780660127, 2932.8533573321247, 2948.7493563047165, 2962.2002059444044, 2963.7184467475554, 72226.27773722248, 72232.63883680548, 72671.63664181698, 72909.6354518224, 74995.0, 12463.5014599415, 12604.621861344174, 12759.29823859678, 12782.488700452064, 12846.935765321301, 22365.664515032287, 23173.7682623175, 23491.295261142193, 23520.294391168292, 23546.882265588905, 5753.194552762617, 5836.153757705109, 5922.289325280908, 5922.851928701817, 5924.407559244128, 2995.0415866922376, 3044.588980487606, 3054.1906394805396, 3056.679048699899, 3060.5715199872034, 3188.28263640679, 3245.7503861013206, 3249.805011699258, 3266.624338201137, 3282.786618869766, 684.6953105867841, 689.6344937183301, 690.5097380859646, 691.2327316678483, 694.6630884021347, 601.7202001069523, 605.7607245138146, 609.5458883132095, 611.7247238742584, 622.890994076044, 9629.759256018655, 9865.309428340091, 10054.0, 10181.33821301613, 10509.474526273656, 596.2040675697991, 596.8895754285471, 600.2586805295457, 602.5330368964001, 602.6354055796268, 4363.432753741993, 4507.526709695435, 4514.210013247734, 4515.300128480091, 4520.299353600197, 62393.68803156046, 63047.36952630507, 63658.68170659117, 66532.66733666397, 66988.0, 56624.716876415354, 57448.42551574514, 58000.419995800345, 58111.70944145337, 58665.706671467226, 50521.49478505241, 51349.74325128351, 51672.0, 51741.22388164105, 54440.72779636076, 9049.230815380766, 9115.22520585731, 9139.497327646777, 9166.129217724305, 9175.77060573491, 26732.599011014463, 26755.33111672224, 26895.0, 28062.85968570144, 28530.286742830765, 32672.183195419355, 32776.83611581927, 45274.54725452703, 45478.54521454876, 46616.30075548937, 13099.0, 13323.13399629021, 13347.532836351069, 13354.599362019155, 13381.866181338062, 14555.92722036383, 14691.191984440959, 15157.696846063238, 15311.77032344538, 15671.68656626884, 14093.436262549383, 14280.500182493563, 14581.489647862274, 14614.19621920762, 14981.176035318162, 13345.466181353026, 14025.438982440588, 14223.502177423741, 14337.78493322622, 14403.711925761636, 13096.083274170716, 13240.20558766477, 13255.337233138498, 13350.0, 13542.390592423562, 10071.84892226632, 10274.897251027693, 10280.794384112425, 10348.17837975223, 10833.187510936868, 9826.263030272616, 9841.114299713061, 10052.54763535628, 10288.228382871164, 10378.481075946323], "value": 6834.672007377531, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 112.0, 113.0, 113.0, 115.0, 113.0, 111.0, 112.0, 111.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 125.0, 161.0, 121.0, 125.0, 126.0, 125.0, 146.0, 124.0], "value": 133.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 165.0, 169.0, 174.0, 166.0, 165.0, 166.0, 164.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 105.0, 74.0, 75.0, 76.0, 75.0, 95.0, 76.0], "value": 80.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 105.0, 84.0, 84.0, 82.0, 96.0, 83.0, 83.0, 101.0], "value": 88.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 114.0, 114.0, 114.0, 113.0, 114.0, 117.0, 115.0, 114.0], "value": 115.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 149.0, 151.0, 153.0, 150.0, 151.0, 150.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 99.0, 95.0, 95.0, 95.0, 96.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 56.0, 54.0, 56.0, 55.0, 59.0, 56.0, 55.0, 54.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 55.0, 56.0, 55.0, 54.0, 55.0, 55.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 81.0, 82.0, 82.0, 84.0, 80.0, 82.0, 89.0, 80.0, 80.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 138.0, 131.0, 130.0, 131.0, 130.0, 132.0, 142.0, 181.0, 146.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 190.0, 191.0, 181.0, 191.0, 191.0, 190.0, 191.0, 196.0, 191.0], "value": 190.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 71.0, 71.0, 71.0, 71.0, 77.0, 72.0, 74.0, 74.0, 70.0], "value": 72.7, "unit": "score"}]}]} 21:50:20 INFO - Return code: 0 21:50:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:50:20 INFO - # TBPL SUCCESS # 21:50:20 INFO - Running post-action listener: _resource_record_post_action 21:50:20 INFO - [mozharness: 2017-05-04 04:50:20.107905Z] Finished run-tests step (success) 21:50:20 INFO - Running post-run listener: _resource_record_post_run 21:50:20 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 368685056; Read time: 12; Write time: 287168 21:50:20 INFO - TinderboxPrint: CPU usage
13.3% 21:50:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 21:50:20 INFO - TinderboxPrint: I/O write bytes / time
368,685,056 / 287,168 21:50:20 INFO - TinderboxPrint: CPU idle
8,303.5 (86.7%) 21:50:20 INFO - TinderboxPrint: CPU user
1,217.3 (12.7%) 21:50:20 INFO - TinderboxPrint: Swap in / out
0 / 0 21:50:20 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115777536; Read time: 0; Write time: 120992 21:50:20 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 252907520; Read time: 0; Write time: 166176 21:50:20 INFO - Running post-run listener: _upload_blobber_files 21:50:20 INFO - Blob upload gear active. 21:50:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:50:20 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 21:50:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:50:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:50:21 INFO - (blobuploader) - INFO - Open directory for files ... 21:50:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:50:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:50:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:50:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:50:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:50:21 INFO - (blobuploader) - INFO - Done attempting. 21:50:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:50:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:50:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:50:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:50:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:50:22 INFO - (blobuploader) - INFO - Done attempting. 21:50:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:50:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:50:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:50:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:50:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:50:23 INFO - (blobuploader) - INFO - Done attempting. 21:50:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:50:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:50:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:50:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:50:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:50:26 INFO - (blobuploader) - INFO - Done attempting. 21:50:26 INFO - (blobuploader) - INFO - Iteration through files over. 21:50:26 INFO - Return code: 0 21:50:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:50:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:50:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80251256013f8ebb0108859f2eb7ea2af09104f5e7e55d80e76f39cb577152cf7be7d9ca748af152b0e32c34c867d967d4d3115ff94a289e9c406c7a1914aa82", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7986d5cc7ce3702a7d416655520f1348a6b1cf3e77584978708fd75d4e48cc481b54f9e242f71be6fbe7272cfada7879b566259cda09267facfce24214b7b46b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d8eb46eaa9a6cdb4724098104fd9f878e3167c4d63e0990f2cc51adc9bc530c44552fbccb2a651bb4476f2ce1d6b91f695d4c8540b3c315d91d26597454fd72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40519d10908e9764983528edcf22a4df4e60409e0aa178968d9e44871e5ec251512de761f0be23b6ef610d83588c6745d0de846d4c3dd0c4500f85cef0c0e03e"} 21:50:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:50:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:50:26 INFO - Contents: 21:50:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80251256013f8ebb0108859f2eb7ea2af09104f5e7e55d80e76f39cb577152cf7be7d9ca748af152b0e32c34c867d967d4d3115ff94a289e9c406c7a1914aa82", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7986d5cc7ce3702a7d416655520f1348a6b1cf3e77584978708fd75d4e48cc481b54f9e242f71be6fbe7272cfada7879b566259cda09267facfce24214b7b46b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d8eb46eaa9a6cdb4724098104fd9f878e3167c4d63e0990f2cc51adc9bc530c44552fbccb2a651bb4476f2ce1d6b91f695d4c8540b3c315d91d26597454fd72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40519d10908e9764983528edcf22a4df4e60409e0aa178968d9e44871e5ec251512de761f0be23b6ef610d83588c6745d0de846d4c3dd0c4500f85cef0c0e03e"} 21:50:26 INFO - Running post-run listener: copy_logs_to_upload_dir 21:50:26 INFO - Copying logs to upload dir... 21:50:26 INFO - mkdir: /builds/slave/test/build/upload/logs 21:50:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.757819 ========= master_lag: -0.26 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-03 21:50:26.466286) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 21:50:26.471124) ========= 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=652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80251256013f8ebb0108859f2eb7ea2af09104f5e7e55d80e76f39cb577152cf7be7d9ca748af152b0e32c34c867d967d4d3115ff94a289e9c406c7a1914aa82", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7986d5cc7ce3702a7d416655520f1348a6b1cf3e77584978708fd75d4e48cc481b54f9e242f71be6fbe7272cfada7879b566259cda09267facfce24214b7b46b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d8eb46eaa9a6cdb4724098104fd9f878e3167c4d63e0990f2cc51adc9bc530c44552fbccb2a651bb4476f2ce1d6b91f695d4c8540b3c315d91d26597454fd72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40519d10908e9764983528edcf22a4df4e60409e0aa178968d9e44871e5ec251512de761f0be23b6ef610d83588c6745d0de846d4c3dd0c4500f85cef0c0e03e"} build_url:https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011193 build_url: 'https://queue.taskcluster.net/v1/task/UrqE72RcRiKfY_A_rSjNgw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80251256013f8ebb0108859f2eb7ea2af09104f5e7e55d80e76f39cb577152cf7be7d9ca748af152b0e32c34c867d967d4d3115ff94a289e9c406c7a1914aa82", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7986d5cc7ce3702a7d416655520f1348a6b1cf3e77584978708fd75d4e48cc481b54f9e242f71be6fbe7272cfada7879b566259cda09267facfce24214b7b46b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d8eb46eaa9a6cdb4724098104fd9f878e3167c4d63e0990f2cc51adc9bc530c44552fbccb2a651bb4476f2ce1d6b91f695d4c8540b3c315d91d26597454fd72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40519d10908e9764983528edcf22a4df4e60409e0aa178968d9e44871e5ec251512de761f0be23b6ef610d83588c6745d0de846d4c3dd0c4500f85cef0c0e03e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 21:50:26.500555) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 21:50:26.503860) ========= 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=652eb03db935cfc1c15ebda0000001ad-1493872171.516057-553742889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 21:50:26.583425) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 21:50:26.586787) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 21:50:26.587092) ========= ========= Total master_lag: -0.07 =========