builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1477621964.88 results: success (0) buildid: 20161027163006 builduid: 22cba9bf2d194a538e35113f88ebe08a revision: 10a2b6ebcd44a3516673f51da14b760de7fd3bc0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 19:32:44.884829) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 19:32:44.885285) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 19:32:44.885579) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 19:32:44.900640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 19:32:44.901060) ========= 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=03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-27 19:32:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.8M=0s 2016-10-27 19:32:45 (69.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.096041 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 19:32:45.011757) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 19:32:45.012076) ========= 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=03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014054 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 19:32:45.062386) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 19:32:45.062701) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 10a2b6ebcd44a3516673f51da14b760de7fd3bc0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 10a2b6ebcd44a3516673f51da14b760de7fd3bc0 --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=03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-27 19:32:45,219 truncating revision to first 12 chars 2016-10-27 19:32:45,220 Setting DEBUG logging. 2016-10-27 19:32:45,220 attempt 1/10 2016-10-27 19:32:45,220 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/10a2b6ebcd44?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-27 19:32:45,542 unpacking tar archive at: mozilla-central-10a2b6ebcd44/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655991 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 19:32:45.732386) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 19:32:45.732688) ========= script_repo_revision: 10a2b6ebcd44a3516673f51da14b760de7fd3bc0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 19:32:45.733074) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 19:32:45.733349) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 19:32:45.742192) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-10-27 19:32:45.742591) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:32:45 INFO - MultiFileLogger online at 20161027 19:32:45 in /builds/slave/test 19:32:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:32:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:32:45 INFO - {'append_to_log': False, 19:32:45 INFO - 'base_work_dir': '/builds/slave/test', 19:32:45 INFO - 'blob_upload_branch': 'Firefox', 19:32:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:32:45 INFO - 'branch': 'Firefox', 19:32:45 INFO - 'buildbot_json_path': 'buildprops.json', 19:32:45 INFO - 'config_files': ('talos/linux_config.py',), 19:32:45 INFO - 'default_actions': ('clobber', 19:32:45 INFO - 'read-buildbot-config', 19:32:45 INFO - 'download-and-extract', 19:32:45 INFO - 'populate-webroot', 19:32:45 INFO - 'create-virtualenv', 19:32:45 INFO - 'install', 19:32:45 INFO - 'run-tests'), 19:32:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:32:45 INFO - 'download_minidump_stackwalk': True, 19:32:45 INFO - 'download_symbols': 'ondemand', 19:32:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:32:45 INFO - 'tooltool.py': '/tools/tooltool.py', 19:32:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:32:45 INFO - '/tools/misc-python/virtualenv.py')}, 19:32:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:32:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:32:45 INFO - 'installer_path': 'installer.exe', 19:32:45 INFO - 'log_level': 'info', 19:32:45 INFO - 'log_name': 'talos', 19:32:45 INFO - 'log_to_console': True, 19:32:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:32:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:32:45 INFO - 'opt_config_files': (), 19:32:45 INFO - 'pip_index': False, 19:32:45 INFO - 'sps_profile': False, 19:32:45 INFO - 'sps_profile_interval': 0, 19:32:45 INFO - 'suite': 'dromaeojs', 19:32:45 INFO - 'system_bits': '32', 19:32:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:32:45 INFO - 'title': 'talos-linux64-ix-047', 19:32:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:32:45 INFO - 'use_talos_json': True, 19:32:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:32:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:32:45 INFO - 'work_dir': 'build'} 19:32:45 INFO - [mozharness: 2016-10-28 02:32:45.993720Z] Running clobber step. 19:32:45 INFO - Running pre-action listener: _resource_record_pre_action 19:32:45 INFO - Running main action method: clobber 19:32:45 INFO - rmtree: /builds/slave/test/build 19:32:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:32:46 INFO - Running post-action listener: _resource_record_post_action 19:32:46 INFO - [mozharness: 2016-10-28 02:32:46.970798Z] Finished clobber step (success) 19:32:46 INFO - [mozharness: 2016-10-28 02:32:46.970901Z] Running read-buildbot-config step. 19:32:46 INFO - Running pre-action listener: _resource_record_pre_action 19:32:46 INFO - Running main action method: read_buildbot_config 19:32:46 INFO - Using buildbot properties: 19:32:46 INFO - { 19:32:46 INFO - "project": "", 19:32:46 INFO - "product": "firefox", 19:32:46 INFO - "script_repo_revision": "production", 19:32:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 19:32:46 INFO - "repository": "", 19:32:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 19:32:46 INFO - "buildid": "20161027163006", 19:32:46 INFO - "pgo_build": "True", 19:32:46 INFO - "basedir": "/builds/slave/test", 19:32:46 INFO - "buildnumber": 46, 19:32:46 INFO - "slavename": "talos-linux64-ix-047", 19:32:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:32:46 INFO - "platform": "ubuntu64_hw", 19:32:46 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:32:46 INFO - "branch": "mozilla-central", 19:32:46 INFO - "repo_path": "mozilla-central", 19:32:46 INFO - "revision": "10a2b6ebcd44a3516673f51da14b760de7fd3bc0", 19:32:46 INFO - "stage_platform": "linux64-pgo", 19:32:46 INFO - "builduid": "22cba9bf2d194a538e35113f88ebe08a", 19:32:46 INFO - "slavebuilddir": "test" 19:32:46 INFO - } 19:32:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/Shx0CdtGSeWCpiJr7hBmWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 19:32:46 INFO - Running post-action listener: _resource_record_post_action 19:32:46 INFO - [mozharness: 2016-10-28 02:32:46.973656Z] Finished read-buildbot-config step (success) 19:32:46 INFO - [mozharness: 2016-10-28 02:32:46.973756Z] Running download-and-extract step. 19:32:46 INFO - Running pre-action listener: _resource_record_pre_action 19:32:46 INFO - Running main action method: download_and_extract 19:32:46 INFO - mkdir: /builds/slave/test/build/tests 19:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:46 INFO - trying https://queue.taskcluster.net/v1/task/Shx0CdtGSeWCpiJr7hBmWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 19:32:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Shx0CdtGSeWCpiJr7hBmWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 19:32:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Shx0CdtGSeWCpiJr7hBmWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:32:47 INFO - Downloaded 1361 bytes. 19:32:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 19:32:47 INFO - Using the following test package requirements: 19:32:47 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 19:32:47 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:32:47 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:32:47 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:47 INFO - u'jsshell-linux-x86_64.zip'], 19:32:47 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:32:47 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 19:32:47 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:32:47 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:32:47 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:32:47 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:32:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:32:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Shx0CdtGSeWCpiJr7hBmWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 19:32:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Shx0CdtGSeWCpiJr7hBmWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:32:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Shx0CdtGSeWCpiJr7hBmWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:32:48 INFO - Http code: 200 19:32:48 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 19:32:48 INFO - x-amz-cf-id: rx-bySV1RFE_NZ-iOzzftDmPnbitINcJiy3RA_mM4Ck7i4kDi-wITQ== 19:32:48 INFO - x-amz-version-id: UCCmw_rddbP30KCqLjx1PGGB0z7pol0Q 19:32:49 INFO - Expected file size: 21992985 19:32:49 INFO - Obtained file size: 21992985 19:32:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:32:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Shx0CdtGSeWCpiJr7hBmWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 19:32:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Shx0CdtGSeWCpiJr7hBmWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:32:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Shx0CdtGSeWCpiJr7hBmWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:32:54 INFO - Http code: 200 19:32:54 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 19:32:54 INFO - x-amz-cf-id: P3PreS1NxamJ6oj1CNDLJLcARVKFTfpyrpPMrG8U4fSVZ-gJFBxL0g== 19:32:54 INFO - x-amz-version-id: UCCmw_rddbP30KCqLjx1PGGB0z7pol0Q 19:32:54 INFO - Expected file size: 21992985 19:32:54 INFO - Obtained file size: 21992985 19:32:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Shx0CdtGSeWCpiJr7hBmWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 19:32:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Shx0CdtGSeWCpiJr7hBmWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:32:58 INFO - Fetch https://queue.taskcluster.net/v1/task/Shx0CdtGSeWCpiJr7hBmWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 19:32:59 INFO - Http code: 200 19:32:59 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 19:32:59 INFO - x-amz-cf-id: 9sYnNO1MEYyX6XSVJxHj3tTkPhPu6Tx8coAiZ5vr4qe1xybxnSnEsA== 19:32:59 INFO - x-amz-version-id: Gl_SXYZQY0FvjUuVVBkgStQUjcbwGYUl 19:33:00 INFO - Expected file size: 14409028 19:33:00 INFO - Obtained file size: 14409028 19:33: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')]} 19:33:00 INFO - trying https://queue.taskcluster.net/v1/task/Shx0CdtGSeWCpiJr7hBmWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:33:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Shx0CdtGSeWCpiJr7hBmWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:33:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Shx0CdtGSeWCpiJr7hBmWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:33:02 INFO - Downloaded 59399761 bytes. 19:33:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Shx0CdtGSeWCpiJr7hBmWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:33:02 INFO - mkdir: /builds/slave/test/properties 19:33:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:33:02 INFO - Writing to file /builds/slave/test/properties/build_url 19:33:02 INFO - Contents: 19:33:02 INFO - build_url:https://queue.taskcluster.net/v1/task/Shx0CdtGSeWCpiJr7hBmWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:33:03 INFO - Running post-action listener: _resource_record_post_action 19:33:03 INFO - Running post-action listener: set_extra_try_arguments 19:33:03 INFO - [mozharness: 2016-10-28 02:33:03.710917Z] Finished download-and-extract step (success) 19:33:03 INFO - [mozharness: 2016-10-28 02:33:03.711144Z] Running populate-webroot step. 19:33:03 INFO - Running pre-action listener: _resource_record_pre_action 19:33:03 INFO - Running main action method: populate_webroot 19:33:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:33:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:33:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:33:03 INFO - '--tppagecycles', 19:33:03 INFO - '7'], 19:33:03 INFO - 'tests': ['tsvgm']}}, 19:33:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:33:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:33:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:33:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:33:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:33:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:33:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:03 INFO - 'talos_options': ['--disable-e10s'], 19:33:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:33:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:33:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:03 INFO - 'talos_options': ['--disable-e10s'], 19:33:03 INFO - 'tests': ['damp', 'tps']}, 19:33:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:03 INFO - 'tests': ['damp', 'tps']}, 19:33:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:33:03 INFO - 'tests': ['dromaeo_dom']}, 19:33:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:33:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:33:03 INFO - 'tests': ['basic_compositor_video']}, 19:33:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:33:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:33:03 INFO - 'tests': ['a11yr', 19:33:03 INFO - 'ts_paint', 19:33:03 INFO - 'tpaint', 19:33:03 INFO - 'sessionrestore', 19:33:03 INFO - 'sessionrestore_no_auto_restore', 19:33:03 INFO - 'tabpaint']}, 19:33:03 INFO - 'other-e10s': {'tests': ['a11yr', 19:33:03 INFO - 'ts_paint', 19:33:03 INFO - 'tpaint', 19:33:03 INFO - 'sessionrestore', 19:33:03 INFO - 'sessionrestore_no_auto_restore', 19:33:03 INFO - 'tabpaint']}, 19:33:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:33:03 INFO - 'ts_paint', 19:33:03 INFO - 'tpaint', 19:33:03 INFO - 'sessionrestore', 19:33:03 INFO - 'sessionrestore_no_auto_restore', 19:33:03 INFO - 'tabpaint']}, 19:33:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:33:03 INFO - 'ts_paint', 19:33:03 INFO - 'tpaint', 19:33:03 INFO - 'sessionrestore', 19:33:03 INFO - 'sessionrestore_no_auto_restore', 19:33:03 INFO - 'tabpaint']}, 19:33:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:33:03 INFO - 'tests': ['a11yr', 19:33:03 INFO - 'ts_paint', 19:33:03 INFO - 'tpaint', 19:33:03 INFO - 'sessionrestore', 19:33:03 INFO - 'sessionrestore_no_auto_restore', 19:33:03 INFO - 'tabpaint']}, 19:33:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:33:03 INFO - 'tests': ['a11yr', 19:33:03 INFO - 'ts_paint', 19:33:03 INFO - 'tpaint', 19:33:03 INFO - 'sessionrestore', 19:33:03 INFO - 'sessionrestore_no_auto_restore', 19:33:03 INFO - 'tabpaint']}, 19:33:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:33:03 INFO - 'tests': ['tsvgx', 19:33:03 INFO - 'tsvgr_opacity', 19:33:03 INFO - 'tart', 19:33:03 INFO - 'tscrollx', 19:33:03 INFO - 'cart']}, 19:33:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:33:03 INFO - 'tsvgr_opacity', 19:33:03 INFO - 'tart', 19:33:03 INFO - 'tscrollx', 19:33:03 INFO - 'cart']}, 19:33:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:03 INFO - 'talos_options': ['--disable-e10s'], 19:33:03 INFO - 'tests': ['tp5o']}, 19:33:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:03 INFO - 'tests': ['tp5o']}, 19:33:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:03 INFO - 'talos_options': ['--disable-e10s', 19:33:03 INFO - '--xperf_path', 19:33:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:33:03 INFO - 'tests': ['tp5n']}, 19:33:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:33:03 INFO - 'talos_options': ['--xperf_path', 19:33:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:33:03 INFO - 'tests': ['tp5n']}}, 19:33:03 INFO - 'talos.zip': {'path': '', 19:33:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:33:03 INFO - Running post-action listener: _resource_record_post_action 19:33:03 INFO - [mozharness: 2016-10-28 02:33:03.733286Z] Finished populate-webroot step (success) 19:33:03 INFO - [mozharness: 2016-10-28 02:33:03.733374Z] Running create-virtualenv step. 19:33:03 INFO - Running pre-action listener: _resource_record_pre_action 19:33:03 INFO - Running main action method: create_virtualenv 19:33:03 INFO - Creating virtualenv /builds/slave/test/build/venv 19:33:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:33:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:33:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:33:03 INFO - Using real prefix '/usr' 19:33:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:33:04 INFO - Installing distribute.............................................................................................................................................................................................done. 19:33:06 INFO - Installing pip.................done. 19:33:06 INFO - Return code: 0 19:33:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:33:06 INFO - Reading from file tmpfile_stdout 19:33:06 INFO - Output received: 19:33:06 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 19:33:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:33: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')]} 19:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33: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')]} 19:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3972c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0930>, '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 0x2ae1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770', '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 19:33:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:33:06 INFO - Using env: {'DISPLAY': ':0', 19:33:06 INFO - 'HOME': '/home/cltbld', 19:33:06 INFO - 'LANG': 'en_US.UTF-8', 19:33:06 INFO - 'LANGUAGE': 'en_US:en', 19:33:06 INFO - 'LOGNAME': 'cltbld', 19:33:06 INFO - 'MAIL': '/var/mail/cltbld', 19:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:06 INFO - 'MOZ_NO_REMOTE': '1', 19:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:06 INFO - 'NO_EM_RESTART': '1', 19:33:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:06 INFO - 'PWD': '/builds/slave/test', 19:33:06 INFO - 'SHELL': '/bin/bash', 19:33:06 INFO - 'SHLVL': '1', 19:33:06 INFO - 'TERM': 'linux', 19:33:06 INFO - 'TMOUT': '86400', 19:33:06 INFO - 'USER': 'cltbld', 19:33:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770', 19:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:06 INFO - '_': '/tools/buildbot/bin/python'} 19:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:33:06 INFO - Cleaning up... 19:33:06 INFO - Return code: 0 19:33:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:33: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')]} 19:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33: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')]} 19:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3972c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0930>, '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 0x2ae1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770', '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 19:33:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:33:06 INFO - Using env: {'DISPLAY': ':0', 19:33:06 INFO - 'HOME': '/home/cltbld', 19:33:06 INFO - 'LANG': 'en_US.UTF-8', 19:33:06 INFO - 'LANGUAGE': 'en_US:en', 19:33:06 INFO - 'LOGNAME': 'cltbld', 19:33:06 INFO - 'MAIL': '/var/mail/cltbld', 19:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:06 INFO - 'MOZ_NO_REMOTE': '1', 19:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:06 INFO - 'NO_EM_RESTART': '1', 19:33:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:06 INFO - 'PWD': '/builds/slave/test', 19:33:06 INFO - 'SHELL': '/bin/bash', 19:33:06 INFO - 'SHLVL': '1', 19:33:06 INFO - 'TERM': 'linux', 19:33:06 INFO - 'TMOUT': '86400', 19:33:06 INFO - 'USER': 'cltbld', 19:33:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770', 19:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:06 INFO - '_': '/tools/buildbot/bin/python'} 19:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:06 INFO - Downloading/unpacking psutil>=3.1.1 19:33: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 19:33: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 19:33: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 19:33: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 19:33: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 19:33: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 19:33:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:33:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:33:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:33:08 INFO - Installing collected packages: psutil 19:33:08 INFO - Running setup.py install for psutil 19:33:09 INFO - building 'psutil._psutil_linux' extension 19:33:09 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 19:33:09 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 19:33:09 INFO - building 'psutil._psutil_posix' extension 19:33:09 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 19:33:09 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 19:33:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:33:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:33:09 INFO - Successfully installed psutil 19:33:09 INFO - Cleaning up... 19:33:09 INFO - Return code: 0 19:33:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:33:09 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')]} 19:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:09 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')]} 19:33:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:09 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 0x7fe3972c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0930>, '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 0x2ae1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770', '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 19:33:09 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 19:33:09 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 19:33:09 INFO - Using env: {'DISPLAY': ':0', 19:33:09 INFO - 'HOME': '/home/cltbld', 19:33:09 INFO - 'LANG': 'en_US.UTF-8', 19:33:09 INFO - 'LANGUAGE': 'en_US:en', 19:33:09 INFO - 'LOGNAME': 'cltbld', 19:33:09 INFO - 'MAIL': '/var/mail/cltbld', 19:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:09 INFO - 'MOZ_NO_REMOTE': '1', 19:33:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:09 INFO - 'NO_EM_RESTART': '1', 19:33:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:09 INFO - 'PWD': '/builds/slave/test', 19:33:09 INFO - 'SHELL': '/bin/bash', 19:33:09 INFO - 'SHLVL': '1', 19:33:09 INFO - 'TERM': 'linux', 19:33:09 INFO - 'TMOUT': '86400', 19:33:09 INFO - 'USER': 'cltbld', 19:33:09 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770', 19:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:09 INFO - '_': '/tools/buildbot/bin/python'} 19:33:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:33: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 19:33: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 19:33: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 19:33: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 19:33: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 19:33: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 19:33:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:33:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:33:11 INFO - Installing collected packages: mozsystemmonitor 19:33:11 INFO - Running setup.py install for mozsystemmonitor 19:33:11 INFO - Successfully installed mozsystemmonitor 19:33:11 INFO - Cleaning up... 19:33:11 INFO - Return code: 0 19:33:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe3972c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0930>, '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 0x2ae1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770', '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 19:33:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:33:11 INFO - Using env: {'DISPLAY': ':0', 19:33:11 INFO - 'HOME': '/home/cltbld', 19:33:11 INFO - 'LANG': 'en_US.UTF-8', 19:33:11 INFO - 'LANGUAGE': 'en_US:en', 19:33:11 INFO - 'LOGNAME': 'cltbld', 19:33:11 INFO - 'MAIL': '/var/mail/cltbld', 19:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:11 INFO - 'MOZ_NO_REMOTE': '1', 19:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:11 INFO - 'NO_EM_RESTART': '1', 19:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:11 INFO - 'PWD': '/builds/slave/test', 19:33:11 INFO - 'SHELL': '/bin/bash', 19:33:11 INFO - 'SHLVL': '1', 19:33:11 INFO - 'TERM': 'linux', 19:33:11 INFO - 'TMOUT': '86400', 19:33:11 INFO - 'USER': 'cltbld', 19:33:11 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770', 19:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:11 INFO - '_': '/tools/buildbot/bin/python'} 19:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:12 INFO - Downloading/unpacking jsonschema==2.5.1 19:33: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 19:33: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 19:33: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 19:33: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 19:33: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 19:33: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 19:33:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:33:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:33:14 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 19:33:14 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 19:33:14 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 19:33:14 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 19:33:14 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 19:33:14 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 19:33:14 INFO - Downloading functools32-3.2.3-2.tar.gz 19:33:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:33:14 INFO - warning: no files found matching '*.txt' 19:33:14 INFO - no previously-included directories found matching 'build' 19:33:14 INFO - no previously-included directories found matching 'dist' 19:33:14 INFO - no previously-included directories found matching '.git*' 19:33:14 INFO - Installing collected packages: jsonschema, functools32 19:33:14 INFO - Running setup.py install for functools32 19:33:14 INFO - warning: no files found matching '*.txt' 19:33:14 INFO - no previously-included directories found matching 'build' 19:33:14 INFO - no previously-included directories found matching 'dist' 19:33:14 INFO - no previously-included directories found matching '.git*' 19:33:14 INFO - Successfully installed jsonschema functools32 19:33:14 INFO - Cleaning up... 19:33:14 INFO - Return code: 0 19:33:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:33:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:14 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 0x7fe3972c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0930>, '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 0x2ae1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770', '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 19:33:14 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 19:33:14 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 19:33:14 INFO - Using env: {'DISPLAY': ':0', 19:33:14 INFO - 'HOME': '/home/cltbld', 19:33:14 INFO - 'LANG': 'en_US.UTF-8', 19:33:14 INFO - 'LANGUAGE': 'en_US:en', 19:33:14 INFO - 'LOGNAME': 'cltbld', 19:33:14 INFO - 'MAIL': '/var/mail/cltbld', 19:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:14 INFO - 'MOZ_NO_REMOTE': '1', 19:33:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:14 INFO - 'NO_EM_RESTART': '1', 19:33:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:14 INFO - 'PWD': '/builds/slave/test', 19:33:14 INFO - 'SHELL': '/bin/bash', 19:33:14 INFO - 'SHLVL': '1', 19:33:14 INFO - 'TERM': 'linux', 19:33:14 INFO - 'TMOUT': '86400', 19:33:14 INFO - 'USER': 'cltbld', 19:33:14 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770', 19:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:14 INFO - '_': '/tools/buildbot/bin/python'} 19:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:33:14 INFO - Cleaning up... 19:33:14 INFO - Return code: 0 19:33:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:33:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:14 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 0x7fe3972c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0930>, '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 0x2ae1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770', '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 19:33:14 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 19:33:14 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 19:33:14 INFO - Using env: {'DISPLAY': ':0', 19:33:14 INFO - 'HOME': '/home/cltbld', 19:33:14 INFO - 'LANG': 'en_US.UTF-8', 19:33:14 INFO - 'LANGUAGE': 'en_US:en', 19:33:14 INFO - 'LOGNAME': 'cltbld', 19:33:14 INFO - 'MAIL': '/var/mail/cltbld', 19:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:14 INFO - 'MOZ_NO_REMOTE': '1', 19:33:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:14 INFO - 'NO_EM_RESTART': '1', 19:33:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:14 INFO - 'PWD': '/builds/slave/test', 19:33:14 INFO - 'SHELL': '/bin/bash', 19:33:14 INFO - 'SHLVL': '1', 19:33:14 INFO - 'TERM': 'linux', 19:33:14 INFO - 'TMOUT': '86400', 19:33:14 INFO - 'USER': 'cltbld', 19:33:14 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770', 19:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:14 INFO - '_': '/tools/buildbot/bin/python'} 19:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:15 INFO - Downloading/unpacking blobuploader==1.2.4 19:33:15 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 19:33:15 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 19:33:15 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 19:33:15 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 19:33:15 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 19:33:15 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 19:33:17 INFO - Downloading blobuploader-1.2.4.tar.gz 19:33:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:33:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:33: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 19:33: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 19:33: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 19:33: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 19:33: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 19:33: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 19:33:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:33:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:33: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 19:33: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 19:33: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 19:33: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 19:33: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 19:33: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 19:33:17 INFO - Downloading docopt-0.6.1.tar.gz 19:33:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:33:17 INFO - Installing collected packages: blobuploader, requests, docopt 19:33:17 INFO - Running setup.py install for blobuploader 19:33:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:33:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:33:17 INFO - Running setup.py install for requests 19:33:18 INFO - Running setup.py install for docopt 19:33:18 INFO - Successfully installed blobuploader requests docopt 19:33:18 INFO - Cleaning up... 19:33:18 INFO - Return code: 0 19:33:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:33:18 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')]} 19:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:18 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')]} 19:33:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:18 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 0x7fe3972c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0930>, '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 0x2ae1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770', '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 19:33:18 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 19:33:18 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 19:33:18 INFO - Using env: {'DISPLAY': ':0', 19:33:18 INFO - 'HOME': '/home/cltbld', 19:33:18 INFO - 'LANG': 'en_US.UTF-8', 19:33:18 INFO - 'LANGUAGE': 'en_US:en', 19:33:18 INFO - 'LOGNAME': 'cltbld', 19:33:18 INFO - 'MAIL': '/var/mail/cltbld', 19:33:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:18 INFO - 'MOZ_NO_REMOTE': '1', 19:33:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:18 INFO - 'NO_EM_RESTART': '1', 19:33:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:18 INFO - 'PWD': '/builds/slave/test', 19:33:18 INFO - 'SHELL': '/bin/bash', 19:33:18 INFO - 'SHLVL': '1', 19:33:18 INFO - 'TERM': 'linux', 19:33:18 INFO - 'TMOUT': '86400', 19:33:18 INFO - 'USER': 'cltbld', 19:33:18 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770', 19:33:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:18 INFO - '_': '/tools/buildbot/bin/python'} 19:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:33:18 INFO - Running setup.py (path:/tmp/pip-Qm_IUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:33:18 INFO - Running setup.py (path:/tmp/pip-wOM3WP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:33:18 INFO - Running setup.py (path:/tmp/pip-vKB72o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:33:18 INFO - Running setup.py (path:/tmp/pip-fwqmPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:33:18 INFO - Running setup.py (path:/tmp/pip-LVDR4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:33:19 INFO - Running setup.py (path:/tmp/pip-5dD1iV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:33:19 INFO - Running setup.py (path:/tmp/pip-EJ1TEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:33:19 INFO - Running setup.py (path:/tmp/pip-tniVyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:33:19 INFO - Running setup.py (path:/tmp/pip-FQjDYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:33:19 INFO - Running setup.py (path:/tmp/pip-TIQ6CX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:33:19 INFO - Running setup.py (path:/tmp/pip-9Pzhql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:33:19 INFO - Running setup.py (path:/tmp/pip-vbmLQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:33:19 INFO - Running setup.py (path:/tmp/pip-uRq8DY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:33:19 INFO - Running setup.py (path:/tmp/pip-o95vIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:33:19 INFO - Running setup.py (path:/tmp/pip-WWyJc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:33:19 INFO - Running setup.py (path:/tmp/pip-Zv9v6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:33:19 INFO - Running setup.py (path:/tmp/pip-6b0zaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:33:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:33:19 INFO - Running setup.py install for manifestparser 19:33:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:33:19 INFO - Running setup.py install for mozcrash 19:33:20 INFO - Running setup.py install for mozdebug 19:33:20 INFO - Running setup.py install for mozdevice 19:33:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:33:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:33:20 INFO - Running setup.py install for mozfile 19:33:20 INFO - Running setup.py install for mozhttpd 19:33:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:33:20 INFO - Running setup.py install for mozinfo 19:33:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:33:20 INFO - Running setup.py install for mozInstall 19:33:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:33:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:33:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:33:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:33:20 INFO - Running setup.py install for mozleak 19:33:20 INFO - Running setup.py install for mozlog 19:33:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:33:20 INFO - Running setup.py install for moznetwork 19:33:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:33:21 INFO - Running setup.py install for mozprocess 19:33:21 INFO - Running setup.py install for mozprofile 19:33:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:33:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:33:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:33:21 INFO - Running setup.py install for mozrunner 19:33:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:33:21 INFO - Running setup.py install for mozscreenshot 19:33:21 INFO - Running setup.py install for moztest 19:33:21 INFO - Running setup.py install for mozversion 19:33:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:33:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:33:21 INFO - Cleaning up... 19:33:21 INFO - Return code: 0 19:33:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:33:21 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')]} 19:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:21 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')]} 19:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:21 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 0x7fe3972c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0930>, '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 0x2ae1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770', '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 19:33:21 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 19:33:21 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 19:33:21 INFO - Using env: {'DISPLAY': ':0', 19:33:21 INFO - 'HOME': '/home/cltbld', 19:33:21 INFO - 'LANG': 'en_US.UTF-8', 19:33:21 INFO - 'LANGUAGE': 'en_US:en', 19:33:21 INFO - 'LOGNAME': 'cltbld', 19:33:21 INFO - 'MAIL': '/var/mail/cltbld', 19:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:21 INFO - 'MOZ_NO_REMOTE': '1', 19:33:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:21 INFO - 'NO_EM_RESTART': '1', 19:33:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:21 INFO - 'PWD': '/builds/slave/test', 19:33:21 INFO - 'SHELL': '/bin/bash', 19:33:21 INFO - 'SHLVL': '1', 19:33:21 INFO - 'TERM': 'linux', 19:33:21 INFO - 'TMOUT': '86400', 19:33:21 INFO - 'USER': 'cltbld', 19:33:21 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770', 19:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:21 INFO - '_': '/tools/buildbot/bin/python'} 19:33:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:33:21 INFO - Running setup.py (path:/tmp/pip-vnn7jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:33:21 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)) 19:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:33:21 INFO - Running setup.py (path:/tmp/pip-7niM2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 19:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:33:22 INFO - Running setup.py (path:/tmp/pip-_LvHHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:33:22 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)) 19:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:33:22 INFO - Running setup.py (path:/tmp/pip-gmmrdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 19:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:33:22 INFO - Running setup.py (path:/tmp/pip-gemNuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:33:22 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)) 19:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:33:22 INFO - Running setup.py (path:/tmp/pip-f5Pzzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:33:22 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)) 19:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:33:22 INFO - Running setup.py (path:/tmp/pip-epguNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:33:22 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)) 19:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:33:22 INFO - Running setup.py (path:/tmp/pip-sphCGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:33:22 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)) 19:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:33:22 INFO - Running setup.py (path:/tmp/pip-ocb6pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:33:22 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)) 19:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:33:22 INFO - Running setup.py (path:/tmp/pip-wtW9M6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:33:22 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)) 19:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:33:22 INFO - Running setup.py (path:/tmp/pip-7IA_wL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:33:22 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)) 19:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:33:22 INFO - Running setup.py (path:/tmp/pip-ZaTQMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 19:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:33:22 INFO - Running setup.py (path:/tmp/pip-wJlL_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:33:22 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)) 19:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:33:22 INFO - Running setup.py (path:/tmp/pip-xUIMvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 19:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:33:22 INFO - Running setup.py (path:/tmp/pip-JHzK7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:33:23 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)) 19:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:33:23 INFO - Running setup.py (path:/tmp/pip-m15lGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 19:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:33:23 INFO - Running setup.py (path:/tmp/pip-nnXXgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:33:23 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)) 19:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:33:23 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)) 19:33:23 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:33:23 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:33:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:33:23 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 19:33:23 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 19:33:23 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 19:33:23 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 19:33:23 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 19:33:23 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 19:33:25 INFO - Downloading blessings-1.6.tar.gz 19:33:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:33:25 INFO - Installing collected packages: blessings 19:33:25 INFO - Running setup.py install for blessings 19:33:25 INFO - Successfully installed blessings 19:33:25 INFO - Cleaning up... 19:33:25 INFO - Return code: 0 19:33:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:33:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:33:25 INFO - Reading from file tmpfile_stdout 19:33:25 INFO - Current package versions: 19:33:25 INFO - argparse == 1.2.1 19:33:25 INFO - blessings == 1.6 19:33:25 INFO - blobuploader == 1.2.4 19:33:25 INFO - docopt == 0.6.1 19:33:25 INFO - functools32 == 3.2.3-2 19:33:25 INFO - jsonschema == 2.5.1 19:33:25 INFO - manifestparser == 1.1 19:33:25 INFO - mozInstall == 1.12 19:33:25 INFO - mozcrash == 0.17 19:33:25 INFO - mozdebug == 0.1 19:33:25 INFO - mozdevice == 0.48 19:33:25 INFO - mozfile == 1.2 19:33:25 INFO - mozhttpd == 0.7 19:33:25 INFO - mozinfo == 0.9 19:33:25 INFO - mozleak == 0.1 19:33:25 INFO - mozlog == 3.4 19:33:25 INFO - moznetwork == 0.27 19:33:25 INFO - mozprocess == 0.23 19:33:25 INFO - mozprofile == 0.28 19:33:25 INFO - mozrunner == 6.12 19:33:25 INFO - mozscreenshot == 0.1 19:33:25 INFO - mozsystemmonitor == 0.3 19:33:25 INFO - moztest == 0.7 19:33:25 INFO - mozversion == 1.4 19:33:25 INFO - psutil == 3.1.1 19:33:25 INFO - requests == 1.2.3 19:33:25 INFO - wsgiref == 0.1.2 19:33:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:33:25 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')]} 19:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:25 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')]} 19:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:25 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 0x7fe3972c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0930>, '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 0x2ae1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770', '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 19:33:25 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 19:33:25 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 19:33:25 INFO - Using env: {'DISPLAY': ':0', 19:33:25 INFO - 'HOME': '/home/cltbld', 19:33:25 INFO - 'LANG': 'en_US.UTF-8', 19:33:25 INFO - 'LANGUAGE': 'en_US:en', 19:33:25 INFO - 'LOGNAME': 'cltbld', 19:33:25 INFO - 'MAIL': '/var/mail/cltbld', 19:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:25 INFO - 'MOZ_NO_REMOTE': '1', 19:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:25 INFO - 'NO_EM_RESTART': '1', 19:33:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:25 INFO - 'PWD': '/builds/slave/test', 19:33:25 INFO - 'SHELL': '/bin/bash', 19:33:25 INFO - 'SHLVL': '1', 19:33:25 INFO - 'TERM': 'linux', 19:33:25 INFO - 'TMOUT': '86400', 19:33:25 INFO - 'USER': 'cltbld', 19:33:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770', 19:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:25 INFO - '_': '/tools/buildbot/bin/python'} 19:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:25 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)) 19:33:25 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)) 19:33:25 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)) 19:33:25 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)) 19:33:25 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)) 19:33:25 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)) 19:33:25 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)) 19:33:25 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)) 19:33:25 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)) 19:33:25 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)) 19:33:25 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)) 19:33:25 INFO - Cleaning up... 19:33:25 INFO - Return code: 0 19:33:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:33:25 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')]} 19:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:25 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')]} 19:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:33:25 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 0x7fe3972c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae0930>, '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 0x2ae1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770', '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 19:33:25 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 19:33:25 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 19:33:25 INFO - Using env: {'DISPLAY': ':0', 19:33:25 INFO - 'HOME': '/home/cltbld', 19:33:25 INFO - 'LANG': 'en_US.UTF-8', 19:33:25 INFO - 'LANGUAGE': 'en_US:en', 19:33:25 INFO - 'LOGNAME': 'cltbld', 19:33:25 INFO - 'MAIL': '/var/mail/cltbld', 19:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:25 INFO - 'MOZ_NO_REMOTE': '1', 19:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:25 INFO - 'NO_EM_RESTART': '1', 19:33:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:25 INFO - 'PWD': '/builds/slave/test', 19:33:25 INFO - 'SHELL': '/bin/bash', 19:33:25 INFO - 'SHLVL': '1', 19:33:25 INFO - 'TERM': 'linux', 19:33:25 INFO - 'TMOUT': '86400', 19:33:25 INFO - 'USER': 'cltbld', 19:33:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770', 19:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:25 INFO - '_': '/tools/buildbot/bin/python'} 19:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:33:26 INFO - Cleaning up... 19:33:26 INFO - Return code: 0 19:33:26 INFO - Running post-action listener: _resource_record_post_action 19:33:26 INFO - Running post-action listener: _start_resource_monitoring 19:33:26 INFO - Starting resource monitoring. 19:33:26 INFO - [mozharness: 2016-10-28 02:33:26.084195Z] Finished create-virtualenv step (success) 19:33:26 INFO - [mozharness: 2016-10-28 02:33:26.084663Z] Running install step. 19:33:26 INFO - Running pre-action listener: _resource_record_pre_action 19:33:26 INFO - Running main action method: install 19:33:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:33:26 INFO - Reading from file tmpfile_stdout 19:33:26 INFO - Detecting whether we're running mozinstall >=1.0... 19:33:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:33:26 INFO - Reading from file tmpfile_stdout 19:33:26 INFO - Output received: 19:33:26 INFO - Usage: mozinstall [options] installer 19:33:26 INFO - Options: 19:33:26 INFO - -h, --help show this help message and exit 19:33:26 INFO - -d DEST, --destination=DEST 19:33:26 INFO - Directory to install application into. [default: 19:33:26 INFO - "/builds/slave/test"] 19:33:26 INFO - --app=APP Application being installed. [default: firefox] 19:33:26 INFO - mkdir: /builds/slave/test/build/application 19:33:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:33:43 INFO - Reading from file tmpfile_stdout 19:33:43 INFO - Output received: 19:33:43 INFO - /builds/slave/test/build/application/firefox/firefox 19:33:43 INFO - Running post-action listener: _resource_record_post_action 19:33:43 INFO - [mozharness: 2016-10-28 02:33:43.266870Z] Finished install step (success) 19:33:43 INFO - [mozharness: 2016-10-28 02:33:43.267118Z] Running run-tests step. 19:33:43 INFO - Running pre-action listener: _resource_record_pre_action 19:33:43 INFO - Running main action method: run_tests 19:33:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:33:43 INFO - Python 2.7.3 19:33:43 INFO - Return code: 0 19:33:43 INFO - grabbing minidump binary from tooltool 19:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:33:43 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 0x2ae0930>, '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 0x2ae1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:33:43 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 19:33:43 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 19:33:43 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 19:33:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:33:43 INFO - Return code: 0 19:33:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:33:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:33:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:33:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:33:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:33:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Shx0CdtGSeWCpiJr7hBmWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Shx0CdtGSeWCpiJr7hBmWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:33:43 INFO - Using env: {'DISPLAY': ':0', 19:33:43 INFO - 'HOME': '/home/cltbld', 19:33:43 INFO - 'LANG': 'en_US.UTF-8', 19:33:43 INFO - 'LANGUAGE': 'en_US:en', 19:33:43 INFO - 'LOGNAME': 'cltbld', 19:33:43 INFO - 'MAIL': '/var/mail/cltbld', 19:33:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:33:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:43 INFO - 'MOZ_NO_REMOTE': '1', 19:33:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:33:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:43 INFO - 'NO_EM_RESTART': '1', 19:33:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:43 INFO - 'PWD': '/builds/slave/test', 19:33:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:33:43 INFO - 'SHELL': '/bin/bash', 19:33:43 INFO - 'SHLVL': '1', 19:33:43 INFO - 'TERM': 'linux', 19:33:43 INFO - 'TMOUT': '86400', 19:33:43 INFO - 'USER': 'cltbld', 19:33:43 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770', 19:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:43 INFO - '_': '/tools/buildbot/bin/python'} 19:33:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Shx0CdtGSeWCpiJr7hBmWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:33:43 INFO - mozversion application_buildid: 20161027163006 19:33:43 INFO - mozversion application_changeset: 10a2b6ebcd44a3516673f51da14b760de7fd3bc0 19:33:43 INFO - mozversion application_display_name: Nightly 19:33:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:33:43 INFO - mozversion application_name: Firefox 19:33:43 INFO - mozversion application_remotingname: firefox 19:33:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:33:43 INFO - mozversion application_vendor: Mozilla 19:33:43 INFO - mozversion application_version: 52.0a1 19:33:43 INFO - mozversion platform_buildid: 20161027163006 19:33:43 INFO - mozversion platform_changeset: 10a2b6ebcd44a3516673f51da14b760de7fd3bc0 19:33:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:33:43 INFO - mozversion platform_version: 52.0a1 19:33:43 INFO - using testdate: 1477622023 19:33:43 INFO - actual date: 1477622023 19:33:43 INFO - starting webserver on 'localhost:45747' 19:33:43 INFO - SUITE-START | Running 2 tests 19:33:43 INFO - TEST-START | dromaeo_css 19:33:43 INFO - operating with platform_type : linux_ 19:33:43 INFO - Initialising browser for dromaeo_css test... 19:33:43 INFO - TEST-INFO | started process 27415 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmgixra/profile http://localhost:45747/getInfo.html) 19:33:47 INFO - PROCESS | 27415 | __metrics Screen width/height:1600/1200 19:33:47 INFO - PROCESS | 27415 | colorDepth:24 19:33:47 INFO - PROCESS | 27415 | Browser inner width/height: 1024/697 19:33:47 INFO - PROCESS | 27415 | __metrics 19:33:48 INFO - PROCESS | 27415 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:33:48 INFO - PROCESS | 27415 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:33:48 INFO - PROCESS | 27415 | console.error: PushService: 19:33:48 INFO - PROCESS | 27415 | stateChangeProcessEnqueue: Error transitioning state 19:33:48 INFO - PROCESS | 27415 | UnknownError 19:33:49 INFO - TEST-INFO | 27415: exit 0 19:33:49 INFO - Browser initialized. 19:33:49 INFO - Running cycle 1/1 for dromaeo_css test... 19:33:49 INFO - TEST-INFO | started process 27499 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmgixra/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:34:01 INFO - PROCESS | 27499 | RSS: Main: 171966464 19:34:01 INFO - PROCESS | 27499 | 19:34:52 INFO - PROCESS | 27499 | 1477622092908 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:37:03 INFO - PROCESS | 27499 | Cycle 1(1): loaded http://localhost:45747/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45747/tests/dromaeo/cssquery-ext.html) 19:37:05 INFO - PROCESS | 27499 | RSS: Main: 296927232 19:37:05 INFO - PROCESS | 27499 | 19:40:07 INFO - PROCESS | 27499 | Cycle 1(1): loaded http://localhost:45747/tests/dromaeo/cssquery-ext.html (next: http://localhost:45747/tests/dromaeo/cssquery-jquery.html) 19:40:08 INFO - PROCESS | 27499 | RSS: Main: 268308480 19:40:08 INFO - PROCESS | 27499 | 19:43:10 INFO - PROCESS | 27499 | Cycle 1(1): loaded http://localhost:45747/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45747/tests/dromaeo/cssquery-mootools.html) 19:43:10 INFO - PROCESS | 27499 | RSS: Main: 263794688 19:43:10 INFO - PROCESS | 27499 | 19:46:12 INFO - PROCESS | 27499 | Cycle 1(1): loaded http://localhost:45747/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45747/tests/dromaeo/cssquery-prototype.html) 19:46:13 INFO - PROCESS | 27499 | RSS: Main: 253616128 19:46:13 INFO - PROCESS | 27499 | 19:49:16 INFO - PROCESS | 27499 | Cycle 1(1): loaded http://localhost:45747/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45747/tests/dromaeo/cssquery-yui.html) 19:49:16 INFO - PROCESS | 27499 | RSS: Main: 215552000 19:49:16 INFO - PROCESS | 27499 | 19:52:19 INFO - PROCESS | 27499 | Cycle 1(1): loaded http://localhost:45747/tests/dromaeo/cssquery-yui.html (next: http://localhost:45747/tests/dromaeo/cssquery-dojo.html) 19:52:20 INFO - PROCESS | 27499 | RSS: Main: 302100480 19:52:20 INFO - PROCESS | 27499 | 19:52:20 INFO - PROCESS | 27499 | __start_tp_report 19:52:20 INFO - PROCESS | 27499 | _x_x_mozilla_page_load 19:52:20 INFO - PROCESS | 27499 | _x_x_mozilla_page_load_details 19:52:20 INFO - PROCESS | 27499 | |i|pagename|runs| 19:52:20 INFO - PROCESS | 27499 | |0;dojo.html;2923.970760292397;2967.7774166937484;2969.064744605449;2980.1655536449775;3025.8638361273743;4996.525330093636;5088.49115088491;5208.505192006758;5258.6581872178285;5297.152455607099;5185.585153187745;5244.842654720364;5335.5198032177095;5358.24984502169;5421;4759.524047595248;4771.308160316752;4822.083804077231;4849.903001939959;4864.927026094611;4839.78220980055;4881.048195601859;4886.853394398174;4889.193283108283;4938.580220681247;4709;4882.829100981484;4886.315915771795;4916.508349165073;4995.35060442142;4734.644901632391;4806.831760888352;4807.975960120212;4819.325294458778;4819.44576373718;4704.129735998851;4776.044791041805;4782.593479554242;4788.401449818773;4789.329493870826;5206.140986737184;5255.395629502618;5259.079661059338;5307.01820163271;5327.7336133193185;5609.046462101453;5609.467100625475;5611.158326251095;5617.129344951539;5617.354004289518;5407.324084489439;5528.281323427969;5669.291338582677;5670.908240725054;5726.398728133528;5235.05768961583;5237.292965449654;5242.606804489678;5247.055530004598;5249.527542521191;5641.915371269434;5671.376148623648;5677.829665110054;5686.800961966312;5689.886202275931;5505.6696598204235;5550.139728342114;5552.278203833556;5575.1915972184615;5646.20953066571;5655.604107712503;5661.886762264814;5662.433756624305;5663.263775709132;5666.688332141689;5394.298741163702;5609.298837645294;5613.859653508695;5621.297337832771;5625.521830644359;5477.04151773446;5512.862178445571;5542.334919809648;5561.555075593943;5638.210650508932;4322.848700295474;4323.156984388077;4368.956310436918;4377.124575084932;4377.474703035656;3838.0788610733225;3838.251540949488;3863;3893.688504919656;3910.2570511602703;5190.6366554341585;5244.29202057725;5254.0805359062015;5287.550558202596;5294.57643388528;5604.747786349624;5647.661140331593;5657.038303488334;5679.943200567942;5738.626989245686;5331.413544510101;5334.91997620036;5338.119210330329;5343.732813359316;5346.251524786533;4822.758862056883;4937.580305673986;4943.085529177042;4948.480409557017;5002.89994200114;5744.856378590485;5775.364709881909;5795.1886735857015;5832.883342333214;5893.793717219876;5596.580256480862;5645.915311270416;5647.548196144381;5649.322081350264;5694.373618901835;5809.883802324014;5860.179574859438;5871.442212989759;5875.853103672443;5881.147233651182;5323.334583177103;5375.569954403716;5481.643693159932;5528.364238112668;5568.777248909998;5645.266115404971;5648.943510564842;5650.519705824887;5672.2058911751565;5715.142728590578;5481.451854814487;5519.558435325244;5522.475364840334;5523.226748255167;5525.668459892419;5385.623006389672;5407.675539467645;5449.836504904859;5519.39286678457;5584.972075139598;5450.918236226539;5511.834644960658;5526.778928842801;5582.637128586629;5593.021221286177;5555.30558680165;5562.944370556243;5565.443455654402;5566.888662226814;5573.665580065209;5273.156294992783;5324.121519949165;5446.373667028342;5457.099578569491;5514.283143191359 19:52:20 INFO - PROCESS | 27499 | |1;ext.html;557.7155650618183;587.847159738468;625.6558892609064;626.1015442839524;658.6245839871275;31431.842840785794;34283.65716342836;34523.30953380937;34532;34546.309073818506;34667.4799878002;43108.56891431085;44169.55830441695;44319.77840110795;47596.28605570919;8691.695790647313;8818.559072046372;8820.294376449869;8828.823423531525;8831.205191532761;8700.390972631918;8787.604557794915;8802.471851688919;8804.735857924272;8805.603747831363;7980.960095199516;8171.142030086845;10445.582176712922;10668.146548276158;10678.78642427151;10517.84223236652;10550.314229575053;10556.78886422275;10563.313384629975;10566.418846963375;10535.84196237057;10569.365838049665;10580.36517808934;10590.152787776959;10590.205734569938;41497.79251103755;41548.376774348406;41837;41837;41915.37126943098;3495.196104895863;3659.3413185626578;3725;3848.672862806665;3954.8418063277436;30950.226244343845;31264.37471250585;31483.527747083812;31544.526832097537;31593.21016974571;4327.913441731148;4328.9783551082355;4471.351654010183;4567.520410356931;4576.977115114403;323076;323714;324724;325168;326600;56028;56284;56382.7180864093;56393;56446;58346.831443597934;58766.706166468895;58783.70608146932;58871;59114.40885591175;14626.853731462763;14841.406343746345;14841.480548180762;14846.703065938837;14849.703005940037;10998.835017474745;11047.613333533287;11078.390688512209;11082.22424430282;11086.778264434666;13935.930320348334;14228.715425691635;14829.406823727146;15696.529104126894;15791.921040394724;6033.245844269466;6293.118963345135;6486.351364863476;6505.381988711065;6516.934830651633;988.7874107067015;992.4045572656493;1020.2195320579763;1044.3994703045628;1111.4776055254017;30753.846230768704;30980.53529197064;31097.844510777755;31204.37591248208;31628.209294767814;1044.0759927464248;1091.476091476096;1095.6767753512734;1118.6420345489528;1120.5797825815318;15819.288132034086;16189.595260118356;16294;16456.506304810875;16626.58433539171;453258;456752;457049;458082;458846;48702.75648621734;49945.500544994815;54449.1832622511;58317;59942.40057599456;1299.9545015924587;1316.5721140629335;1332.7001424679563;1339.9196048236943;1356.3557310277736;29787;31525.211869703442;31884.202894927814;31922.84038579792;32567.837160814044;48897.511024889296;49399;49435.50564494309;49491;49519.81962615473;431291;438355;439209;598560;600470;26422.339441514116;26469.735302647496;26527.469450611265;26754;26809.597856032564;45230.54769452395;45526.54473455223;46758.298625521325;47285.52714472811;47518.76240618775;39271;39318.0681931816;39804;41297.1740565193;41333;38864;39227.803860980515;39846.800765995984;39926.401103982884;41386.58613413827;39812.2037559253;39836.2032759349;40958.385624215065;41198.1760364785;41212.58787412087;31468;35259.647403526666;35487.82256088703;36127.63872361243;36200.818995904854;26976.460470790866;27419.314517136434;27585.071678687553;27699.446011079264;27727.30681732892 19:52:20 INFO - PROCESS | 27499 | |2;jquery.html;367.2288194790941;380.2262396024092;390.3227899594203;398.18372336709746;418.7215501691375;13369.863561597263;14532.128072315669;16060.91969540152;19099;19321.323753668625;18168.182431790567;18472.53818654531;18648.34730784423;18839.152238149283;18862.62274754504;5123.001014802106;5300.867478313054;5310.176922577007;5318.30861987941;5348.598855085884;5058.544730974211;5114.948850511503;5706.3722990471015;5785.768569257225;5789.2763404574425;5768.884622307552;5771.913421298684;5772.740226689809;5775.768969241225;5776.075827867542;5113.105206588851;5179.870503237412;5189.221616757479;5204.29741984831;5214.739263036833;4940.802367905316;5068.898622027576;5076.06092872816;5079.060373830853;5088.898222035538;13968.650783730387;15645.608859778597;21369.145234190615;22284.55430891373;22395.888020559956;2202.7466841313294;2267.4218074391088;2322.1408079010876;2356.882155892216;2587.702414222351;9975.800483990351;10004.449755263531;10041.24690648197;10531.157507399466;10638.202134839918;1876.352658332873;1923.471045462495;1928.4407521818655;1929.2958070304237;1933.4586315831589;71750;81566;84846;85450.57274713587;87648.12351876464;10804;10892.40091794959;10892.727681808019;11229.775404491864;11288.2662626929;15515.146666933428;15531;15536.980192574892;15537.68924621524;15544.533663990098;7369.963150184215;7425.257474252639;7712.5758083305955;7753;7898.842023159505;7222.277772222736;7225.349718525253;7319.487635865545;7348.52234604749;7431.145418276968;4572.95427045732;4636.397268355092;4657.604103651228;4753.191957367256;4836.347093142451;1841.1530695880044;1899.9620007600047;1914.3012800328058;1965.84273258139;1977.1300627723756;431.2948329481258;437.79423670875275;843.7932706486949;974.3277138774223;1026.7895081508273;11121.332720036824;11663.59177428786;11852.88147118535;11929.642110736691;12424.56514022005;454.62720569133654;457.1611093643136;467.6515995583312;468.14797069333486;474.50888330577686;6283.3088360280335;6351;6359.7456101755415;6418.775342862978;6567.211934567882;419484;421867;424041;442923;444556;92889;93075.53462232645;94155.52922235482;95232.52383738037;100948.49525752325;441.9027813880941;442.48450555103585;443.9533848945879;445.13865669928146;445.2875399360997;10763.892361076601;10807.459627018461;10834.837477438003;10902.672919812418;11007.61473348429;39557.60442395539;40107;40182.397264040475;40474.39288410617;41426.585734142274;57183.42816571781;57711.71144144252;58042.4195758037;59322.40677593169;61039.38960610515;8275.95862020686;8337.333013359039;8386.203310685476;8619.1811777881;8741.256993155654;11571.537138514364;12924.224546527239;13019.544315948897;13125.278109703677;13186.670333241746;11049.33703977764;11068.501917413574;11453.885461145283;11539.365334906324;11619.47712352963;11371.545138194711;11382.54469821198;11437.485313160762;11487.54049837997;11723.765524689288;11451.770964580495;11687.707807304885;11831.881681183422;12050.75898482043;12170.695732606755;8539.231469167804;11594.478248479007;11881.762364752829;12164.93917530442;12432.937835311128;11962.222455540363;12488.562900298446;12554.497820087094;12558.93720531428;12695.619131426072 19:52:20 INFO - PROCESS | 27499 | |3;mootools.html;1351.0947665064407;1438.2017980021092;1485.598888300159;1595.3857764760564;1753.9210735516901;7445.8883116753295;8252.504849709021;8355.916440835605;8416.284615807665;8647.524386158759;8452.830943381145;8508.787280317994;8513.48919064855;8519.659213631447;8520.488770673765;2275.283285764983;2319.5360927814504;2319.9188028419007;2320.0835669910375;2327.2203811723007;2254.7632498587577;2298.6781850540856;2330;2342.7188737351544;2348.7064116985375;2226.265332440299;2279.133929106937;2279.9772002280015;2282.315305408379;2287.7025986621716;2262.66060090986;2276.1236923784295;2288.702468679078;2294.162630639813;2294.541091781642;2226.6548684953696;2277.271273192579;2284.6801447797156;2284.7029886114697;2285.108807565051;8565.871511927326;8619.956900215459;8637.481751094892;8638.17937295956;8644.351673624504;5059.772310246048;5086.364204474404;5201.921971170435;5211.869703257411;5239.13554263546;3297.9010629681147;3527.382708026111;3564.2515071834687;3607.080194550399;3610.3501369753435;1086.9239153259275;1149.3448734221497;1245.8446886885647;1256.8994480441634;2147.688585155159;11848.407579620984;12004.459799309052;12020.33888136161;12021.39893005355;12024.218425802383;4421.7789110544345;4440.7335559866515;4454.28731402974;4491.483479399845;4496.820127194941;9369;9370.718878433521;9375.249980001583;9376.859347109663;9378.90621093794;5034.244863270539;5034.395872495324;5055.570276526537;5064.949350506447;5073.188289873602;3927.2145570885937;4093.242750091183;4270.231358355463;4670.7664616769025;4745.6440766942615;3615.584207816082;3633.218857945554;3711.387621042498;3735.122246272124;3758.567764707039;1148.8219326004482;1169.4564322598314;1172.8240763885485;1189.1972918280298;1191.142377488207;842.2251528593708;851.0680804519042;870.8373972411881;926.1895841139003;929.2380248196549;5563.749631266603;5716.885662286731;5817.127430885401;5824.708764561755;5952.0476723724;840.3949156607233;858.2233079063458;882.3558802074522;883.9779005524913;921.1617428140494;3726.06848287928;3810.5046343975105;3867.7099217558793;3927.0575061985487;3997.980010099931;10412.739681507872;10783.352998819939;10808.78382432347;10874.728131796768;10877.129829613612;10721.731956700989;10733.677989660322;10753.354798712102;10753.83869241962;10775.676729698122;7718.807029824299;8012.959935200403;8029;8223.794405139919;8231.42380033404;5426.728663566727;5477.068898287381;5722.828315150552;5772;5878.2064421302575;9381.85927211106;9786.217102631916;9827.164691001344;9834.311598188058;9867.901320986699;9913.702588922344;10048.397096174253;10048.648297309559;10143.34068285559;10203.18374530021;7715.614219289126;7819.100803407453;7840.098388685375;7895.328897043815;7919.366450684047;8302.54336011525;8311.418200726133;8352.373571982003;8391.286740627114;8401.915980840358;7449.776506704591;7529.698812047457;7551;7560.243975602396;7653.502522336031;7316.926830731624;7384.040074790243;7389.852202956018;7476.663550140148;7568.205338439385;6561.540692151503;6686.0973768540625;6713.530052896251;6730.427913627396;6731.48541578141;4927.975360123177;5020.623453240948;5037.596992240538;5058.54473097423;5250.684958902478;5138.948610513847;5191.195364718475;5199.974000129975;5266.183741520071;5401.648892821954 19:52:20 INFO - PROCESS | 27499 | |4;prototype.html;325.92503724143444;330.7684620765464;338.08716465543023;341.9367417027852;342.36149581031367;5029.874253143673;5087.720175390352;5127.641065125443;5241.816536421226;5246.711430871305;4996.67521611095;5111.7699703513335;5111.948880511194;5140.2546630738525;5146.356705411824;4079.796010199493;4087.4277601135864;4088.7751173685438;4089.427480152781;4104.199681062194;3811.6760075393486;3827.0623697194087;4098.4876890388705;4108.5686002969705;4121.743822380331;4044.5550989391145;4048.554658987509;4062.2281766464425;4063.3701776224734;4074.775887326196;4045.63589276965;4049.6760259179196;4056.1482088761395;4057.8376864925367;4062.4718786557855;3626.1116026573395;3631.110377957391;3633.745637805355;3649.6350364963555;3654.689351405107;4855.543336998921;4977.705796492902;5005.199168133117;5026.623003274769;5065.898682026339;4651;4657.115148121846;4663.393758811367;4672.836450724209;4701.717896926195;5372.516473517363;5373.838784836461;5378.408375078739;5391.975524650343;5427.914417116593;3711.645249483946;3885.8445662173763;3888.591697871739;3889.8444062237477;3896.811472500886;5568.9443105569235;5573.721313934328;5579.553635709133;5585.497305242548;5600.18797274397;3962.9405558916637;3964.207158568298;3974.20515896816;3991.1419044904906;3992.321305378093;3943.546492153439;3998.300297447993;4016.758994460342;4019.9196016079513;4045.7370270932297;4552.6130278926;4559.772011399416;4566.328697711876;4577.725336479822;4579.7252164870215;5361.195820626859;5371.435999220103;5376.623636345496;5380.569554435636;5389.299391079135;1286.035473394954;1301.4208677138772;1363.9590812275649;1371.1019282370064;1394.958151255464;872.3457406944791;882.3911501064246;893.9106089391139;897.8742975983367;899.9325050621229;4554.749488778149;4566.46099273066;4572.268437050123;4608.400907882021;4611.331356953223;4809.9038019239415;4833.32333473314;4834.299026641117;4840.419149702058;4840.636952228597;4551.544845515422;4566.196352440767;4601;4630.583247507673;4651.325522811785;2447.5961466357853;2557.7698007179442;2601.2586412872242;2622.0858773095747;2622.895084196649;5005.8486548093415;5028.547430731252;5034.723090230073;5042.823501177441;5106.974465127651;4843.515648435128;4845.563899249085;4886.975565122223;4934.309196712463;4936.605071594264;5297.986765029341;5799.5070419014855;5809.593328466966;5825.563082768725;5830.329512106162;5524.226608274925;5546.58400619947;5547.55619550443;5573.665580065047;5575.219469274386;5414.648047876875;5466.91799623014;5496.862578435571;5526.281583394133;5547.669978608913;5780.913286300793;5781.335146458211;5784.82645520635;5786.681732504752;5821.738021788945;3957.4459575660007;3974.6621537169663;3983.7012224083887;3986.202759448064;3991.680665546807;5229.954009198252;5266.947330526646;5488.204210389551;5509.724513774215;5584.888302234014;5256.294312509748;5274.578033757213;5416.864578385572;5420.728963551728;5425.755840987244;5413.864653383697;5418.295621569171;5426.918596220981;5430.67415955044;5431.158170483582;5280.234366016983;5370.194470829407;5391.708523877415;5394.649347792538;5406.702631355313;5385.226608296652;5394.190871369326;5400.486953739389;5425.918611220914;5430.647007944471;5259.106721580151;5297.516695325315;5297.8145764898045;5302.549283310807;5310.7875684973715 19:52:20 INFO - PROCESS | 27499 | |5;yui.html;729.2906851048355;764.9770506884795;774.8400218264794;783.843231353729;810.9310708589769;12654.873451265485;13103.624119467462;13456.259905705183;14168.504102356419;14412.135271883695;12298.938505307484;12401.627951161458;12429.564965226218;12433.502659893593;12435.502579896816;781.4022272961175;804.1917872538091;808.8665370213907;815.6778072661295;816.4488969945263;674.4873895839173;696.2271878215178;781.9413543984195;812.1796985045117;816.5345752920838;853.2363534636496;854.9572521373938;863.0161615758041;863.22741146674;863.5078005536847;853.6713365354352;859.9054104048549;860.694453469022;860.9913900860973;861.5089399042548;511.53961434708685;524.847794139699;597.9342272350038;629.2669040567733;629.6411045703951;13110.082294239408;13690.315484225748;13706.246156461391;13726.794098088536;13740;13838.169709817343;14138.929305353511;14571.70856582873;14608.926955365261;14637.341319640534;12806.80789788154;12854.164479308814;13060.86939130606;13083.803742943863;13285.800712989312;4498.460184777848;4549.431321084864;4569.565891240327;4619.053094115732;4798.832040878588;71400.66051115197;72388.63805680991;73331.63334183295;73735;73918.63040684815;11470.942645286721;11516.654500365003;11559.653210403701;11609.477573509212;11655.242409243372;20887.68668469974;21197.25809596657;21647.13411463524;21786.564268714537;21880.124795008338;7907.881381779278;8034.196580341919;8074;8113.675452981933;8336.374771892133;4568.383268258809;4571.428571428572;4576.473705523841;4594.977025114853;4629.166749985035;3259.1689119274433;3360.5295258663805;3366.5791776027995;3375.4093033719;3393.253484233514;585.2508788750406;594.111802854735;598.7067933264216;599.3437186281016;599.9190109335271;642.6080091144398;645.8611398549334;668.518666560076;681.5399605266425;684.5618803965466;8350.540720260322;8566.871496927552;8851.380403371832;8915.197632213132;8997.775055623531;629.3077614623969;641.7914177892204;659.6240143118376;669.1167658690579;682.3756263019282;4055.513338399411;4185.979070104691;4194.412782210493;4235.195312890541;4336.891577710582;85191;88790;90181.54909225412;92069;92237.0776292242;66388;68133.65933170401;74812;81385.59307203426;82100.58949705213;41531.58468415398;50722.985540288246;62011;64192.67903660452;65595;8241.50550966944;8656.48061116335;8755.080716524928;8827.514486703036;8875.955620221857;31986.68013319837;32523;40284.39573406343;42796;43063.56936430596;58686;60388;60796;63666;64129.67935160294;10048.296619236875;10061.144802691853;10580.947095264475;10894.782104358026;11089.722756931142;12490.188137771016;12697.111202215756;12765;13466.730665386833;13529.59411217665;12560.685982850502;12714.809277860655;13081.345932703136;13222.537211197561;13567.728645427234;11982.700432489257;12372;12384.256944583354;12476.688082798002;12953.481860725466;11982.940085299517;12299.631011069681;12481.687957801129;13054.216746995211;13094.214347139203;10252.282340236112;10285.702971865143;10376.740581485523;10921.890781092088;10923.126149908147;10831.187660925305;11045.779084418105;11052.502637381176;11142.498587563417;11417.31496110236 19:52:20 INFO - PROCESS | 27499 | __end_tp_report 19:52:20 INFO - PROCESS | 27499 | __start_cc_report 19:52:20 INFO - PROCESS | 27499 | _x_x_mozilla_cycle_collect,1242 19:52:20 INFO - PROCESS | 27499 | __end_cc_report 19:52:20 INFO - PROCESS | 27499 | __startTimestamp1477623140019__endTimestamp 19:52:20 INFO - PROCESS | 27499 | 19:52:20 INFO - PROCESS | 27499 | ------- Summary: start ------- 19:52:20 INFO - PROCESS | 27499 | Number of tests: 6 19:52:20 INFO - PROCESS | 27499 | 19:52:20 INFO - PROCESS | 27499 | [#0] dojo.html Cycles:165 Average:5232.66 Median:5421.00 stddev:590.80 (10.9%) stddev-sans-first:564.16 19:52:20 INFO - PROCESS | 27499 | Values: 2924.0 2967.8 2969.1 2980.2 3025.9 4996.5 5088.5 5208.5 5258.7 5297.2 5185.6 5244.8 5335.5 5358.2 5421.0 4759.5 4771.3 4822.1 4849.9 4864.9 4839.8 4881.0 4886.9 4889.2 4938.6 4709.0 4882.8 4886.3 4916.5 4995.4 4734.6 4806.8 4808.0 4819.3 4819.4 4704.1 4776.0 4782.6 4788.4 4789.3 5206.1 5255.4 5259.1 5307.0 5327.7 5609.0 5609.5 5611.2 5617.1 5617.4 5407.3 5528.3 5669.3 5670.9 5726.4 5235.1 5237.3 5242.6 5247.1 5249.5 5641.9 5671.4 5677.8 5686.8 5689.9 5505.7 5550.1 5552.3 5575.2 5646.2 5655.6 5661.9 5662.4 5663.3 5666.7 5394.3 5609.3 5613.9 5621.3 5625.5 5477.0 5512.9 5542.3 5561.6 5638.2 4322.8 4323.2 4369.0 4377.1 4377.5 3838.1 3838.3 3863.0 3893.7 3910.3 5190.6 5244.3 5254.1 5287.6 5294.6 5604.7 5647.7 5657.0 5679.9 5738.6 5331.4 5334.9 5338.1 5343.7 5346.3 4822.8 4937.6 4943.1 4948.5 5002.9 5744.9 5775.4 5795.2 5832.9 5893.8 5596.6 5645.9 5647.5 5649.3 5694.4 5809.9 5860.2 5871.4 5875.9 5881.1 5323.3 5375.6 5481.6 5528.4 5568.8 5645.3 5648.9 5650.5 5672.2 5715.1 5481.5 5519.6 5522.5 5523.2 5525.7 5385.6 5407.7 5449.8 5519.4 5585.0 5450.9 5511.8 5526.8 5582.6 5593.0 5555.3 5562.9 5565.4 5566.9 5573.7 5273.2 5324.1 5446.4 5457.1 5514.3 19:52:20 INFO - PROCESS | 27499 | 19:52:20 INFO - PROCESS | 27499 | [#1] ext.html Cycles:180 Average:58172.02 Median:21356.34 stddev:115915.04 (542.8%) stddev-sans-first:116159.49 19:52:20 INFO - PROCESS | 27499 | Values: 557.7 587.8 625.7 626.1 658.6 31431.8 34283.7 34523.3 34532.0 34546.3 34667.5 43108.6 44169.6 44319.8 47596.3 8691.7 8818.6 8820.3 8828.8 8831.2 8700.4 8787.6 8802.5 8804.7 8805.6 7981.0 8171.1 10445.6 10668.1 10678.8 10517.8 10550.3 10556.8 10563.3 10566.4 10535.8 10569.4 10580.4 10590.2 10590.2 41497.8 41548.4 41837.0 41837.0 41915.4 3495.2 3659.3 3725.0 3848.7 3954.8 30950.2 31264.4 31483.5 31544.5 31593.2 4327.9 4329.0 4471.4 4567.5 4577.0 323076.0 323714.0 324724.0 325168.0 326600.0 56028.0 56284.0 56382.7 56393.0 56446.0 58346.8 58766.7 58783.7 58871.0 59114.4 14626.9 14841.4 14841.5 14846.7 14849.7 10998.8 11047.6 11078.4 11082.2 11086.8 13935.9 14228.7 14829.4 15696.5 15791.9 6033.2 6293.1 6486.4 6505.4 6516.9 988.8 992.4 1020.2 1044.4 1111.5 30753.8 30980.5 31097.8 31204.4 31628.2 1044.1 1091.5 1095.7 1118.6 1120.6 15819.3 16189.6 16294.0 16456.5 16626.6 453258.0 456752.0 457049.0 458082.0 458846.0 48702.8 49945.5 54449.2 58317.0 59942.4 1300.0 1316.6 1332.7 1339.9 1356.4 29787.0 31525.2 31884.2 31922.8 32567.8 48897.5 49399.0 49435.5 49491.0 49519.8 431291.0 438355.0 439209.0 598560.0 600470.0 26422.3 26469.7 26527.5 26754.0 26809.6 45230.5 45526.5 46758.3 47285.5 47518.8 39271.0 39318.1 39804.0 41297.2 41333.0 38864.0 39227.8 39846.8 39926.4 41386.6 39812.2 39836.2 40958.4 41198.2 41212.6 31468.0 35259.6 35487.8 36127.6 36200.8 26976.5 27419.3 27585.1 27699.4 27727.3 19:52:20 INFO - PROCESS | 27499 | 19:52:20 INFO - PROCESS | 27499 | [#2] jquery.html Cycles:180 Average:26707.40 Median:40144.70 stddev:71645.90 (178.5%) stddev-sans-first:71819.59 19:52:20 INFO - PROCESS | 27499 | Values: 367.2 380.2 390.3 398.2 418.7 13369.9 14532.1 16060.9 19099.0 19321.3 18168.2 18472.5 18648.3 18839.2 18862.6 5123.0 5300.9 5310.2 5318.3 5348.6 5058.5 5114.9 5706.4 5785.8 5789.3 5768.9 5771.9 5772.7 5775.8 5776.1 5113.1 5179.9 5189.2 5204.3 5214.7 4940.8 5068.9 5076.1 5079.1 5088.9 13968.7 15645.6 21369.1 22284.6 22395.9 2202.7 2267.4 2322.1 2356.9 2587.7 9975.8 10004.4 10041.2 10531.2 10638.2 1876.4 1923.5 1928.4 1929.3 1933.5 71750.0 81566.0 84846.0 85450.6 87648.1 10804.0 10892.4 10892.7 11229.8 11288.3 15515.1 15531.0 15537.0 15537.7 15544.5 7370.0 7425.3 7712.6 7753.0 7898.8 7222.3 7225.3 7319.5 7348.5 7431.1 4573.0 4636.4 4657.6 4753.2 4836.3 1841.2 1900.0 1914.3 1965.8 1977.1 431.3 437.8 843.8 974.3 1026.8 11121.3 11663.6 11852.9 11929.6 12424.6 454.6 457.2 467.7 468.1 474.5 6283.3 6351.0 6359.7 6418.8 6567.2 419484.0 421867.0 424041.0 442923.0 444556.0 92889.0 93075.5 94155.5 95232.5 100948.5 441.9 442.5 444.0 445.1 445.3 10763.9 10807.5 10834.8 10902.7 11007.6 39557.6 40107.0 40182.4 40474.4 41426.6 57183.4 57711.7 58042.4 59322.4 61039.4 8276.0 8337.3 8386.2 8619.2 8741.3 11571.5 12924.2 13019.5 13125.3 13186.7 11049.3 11068.5 11453.9 11539.4 11619.5 11371.5 11382.5 11437.5 11487.5 11723.8 11451.8 11687.7 11831.9 12050.8 12170.7 8539.2 11594.5 11881.8 12164.9 12432.9 11962.2 12488.6 12554.5 12558.9 12695.6 19:52:20 INFO - PROCESS | 27499 | 19:52:20 INFO - PROCESS | 27499 | [#3] mootools.html Cycles:180 Average:5639.50 Median:5059.16 stddev:3194.02 (63.1%) stddev-sans-first:3186.72 19:52:20 INFO - PROCESS | 27499 | Values: 1351.1 1438.2 1485.6 1595.4 1753.9 7445.9 8252.5 8355.9 8416.3 8647.5 8452.8 8508.8 8513.5 8519.7 8520.5 2275.3 2319.5 2319.9 2320.1 2327.2 2254.8 2298.7 2330.0 2342.7 2348.7 2226.3 2279.1 2280.0 2282.3 2287.7 2262.7 2276.1 2288.7 2294.2 2294.5 2226.7 2277.3 2284.7 2284.7 2285.1 8565.9 8620.0 8637.5 8638.2 8644.4 5059.8 5086.4 5201.9 5211.9 5239.1 3297.9 3527.4 3564.3 3607.1 3610.4 1086.9 1149.3 1245.8 1256.9 2147.7 11848.4 12004.5 12020.3 12021.4 12024.2 4421.8 4440.7 4454.3 4491.5 4496.8 9369.0 9370.7 9375.2 9376.9 9378.9 5034.2 5034.4 5055.6 5064.9 5073.2 3927.2 4093.2 4270.2 4670.8 4745.6 3615.6 3633.2 3711.4 3735.1 3758.6 1148.8 1169.5 1172.8 1189.2 1191.1 842.2 851.1 870.8 926.2 929.2 5563.7 5716.9 5817.1 5824.7 5952.0 840.4 858.2 882.4 884.0 921.2 3726.1 3810.5 3867.7 3927.1 3998.0 10412.7 10783.4 10808.8 10874.7 10877.1 10721.7 10733.7 10753.4 10753.8 10775.7 7718.8 8013.0 8029.0 8223.8 8231.4 5426.7 5477.1 5722.8 5772.0 5878.2 9381.9 9786.2 9827.2 9834.3 9867.9 9913.7 10048.4 10048.6 10143.3 10203.2 7715.6 7819.1 7840.1 7895.3 7919.4 8302.5 8311.4 8352.4 8391.3 8401.9 7449.8 7529.7 7551.0 7560.2 7653.5 7316.9 7384.0 7389.9 7476.7 7568.2 6561.5 6686.1 6713.5 6730.4 6731.5 4928.0 5020.6 5037.6 5058.5 5250.7 5138.9 5191.2 5200.0 5266.2 5401.6 19:52:20 INFO - PROCESS | 27499 | 19:52:20 INFO - PROCESS | 27499 | [#4] prototype.html Cycles:180 Average:4454.74 Median:4957.16 stddev:1306.45 (26.4%) stddev-sans-first:1272.83 19:52:20 INFO - PROCESS | 27499 | Values: 325.9 330.8 338.1 341.9 342.4 5029.9 5087.7 5127.6 5241.8 5246.7 4996.7 5111.8 5111.9 5140.3 5146.4 4079.8 4087.4 4088.8 4089.4 4104.2 3811.7 3827.1 4098.5 4108.6 4121.7 4044.6 4048.6 4062.2 4063.4 4074.8 4045.6 4049.7 4056.1 4057.8 4062.5 3626.1 3631.1 3633.7 3649.6 3654.7 4855.5 4977.7 5005.2 5026.6 5065.9 4651.0 4657.1 4663.4 4672.8 4701.7 5372.5 5373.8 5378.4 5392.0 5427.9 3711.6 3885.8 3888.6 3889.8 3896.8 5568.9 5573.7 5579.6 5585.5 5600.2 3962.9 3964.2 3974.2 3991.1 3992.3 3943.5 3998.3 4016.8 4019.9 4045.7 4552.6 4559.8 4566.3 4577.7 4579.7 5361.2 5371.4 5376.6 5380.6 5389.3 1286.0 1301.4 1364.0 1371.1 1395.0 872.3 882.4 893.9 897.9 899.9 4554.7 4566.5 4572.3 4608.4 4611.3 4809.9 4833.3 4834.3 4840.4 4840.6 4551.5 4566.2 4601.0 4630.6 4651.3 2447.6 2557.8 2601.3 2622.1 2622.9 5005.8 5028.5 5034.7 5042.8 5107.0 4843.5 4845.6 4887.0 4934.3 4936.6 5298.0 5799.5 5809.6 5825.6 5830.3 5524.2 5546.6 5547.6 5573.7 5575.2 5414.6 5466.9 5496.9 5526.3 5547.7 5780.9 5781.3 5784.8 5786.7 5821.7 3957.4 3974.7 3983.7 3986.2 3991.7 5230.0 5266.9 5488.2 5509.7 5584.9 5256.3 5274.6 5416.9 5420.7 5425.8 5413.9 5418.3 5426.9 5430.7 5431.2 5280.2 5370.2 5391.7 5394.6 5406.7 5385.2 5394.2 5400.5 5425.9 5430.6 5259.1 5297.5 5297.8 5302.5 5310.8 19:52:20 INFO - PROCESS | 27499 | 19:52:20 INFO - PROCESS | 27499 | [#5] yui.html Cycles:180 Average:17379.93 Median:4573.95 stddev:23320.42 (509.9%) stddev-sans-first:23352.33 19:52:20 INFO - PROCESS | 27499 | Values: 729.3 765.0 774.8 783.8 810.9 12654.9 13103.6 13456.3 14168.5 14412.1 12298.9 12401.6 12429.6 12433.5 12435.5 781.4 804.2 808.9 815.7 816.4 674.5 696.2 781.9 812.2 816.5 853.2 855.0 863.0 863.2 863.5 853.7 859.9 860.7 861.0 861.5 511.5 524.8 597.9 629.3 629.6 13110.1 13690.3 13706.2 13726.8 13740.0 13838.2 14138.9 14571.7 14608.9 14637.3 12806.8 12854.2 13060.9 13083.8 13285.8 4498.5 4549.4 4569.6 4619.1 4798.8 71400.7 72388.6 73331.6 73735.0 73918.6 11470.9 11516.7 11559.7 11609.5 11655.2 20887.7 21197.3 21647.1 21786.6 21880.1 7907.9 8034.2 8074.0 8113.7 8336.4 4568.4 4571.4 4576.5 4595.0 4629.2 3259.2 3360.5 3366.6 3375.4 3393.3 585.3 594.1 598.7 599.3 599.9 642.6 645.9 668.5 681.5 684.6 8350.5 8566.9 8851.4 8915.2 8997.8 629.3 641.8 659.6 669.1 682.4 4055.5 4186.0 4194.4 4235.2 4336.9 85191.0 88790.0 90181.5 92069.0 92237.1 66388.0 68133.7 74812.0 81385.6 82100.6 41531.6 50723.0 62011.0 64192.7 65595.0 8241.5 8656.5 8755.1 8827.5 8876.0 31986.7 32523.0 40284.4 42796.0 43063.6 58686.0 60388.0 60796.0 63666.0 64129.7 10048.3 10061.1 10580.9 10894.8 11089.7 12490.2 12697.1 12765.0 13466.7 13529.6 12560.7 12714.8 13081.3 13222.5 13567.7 11982.7 12372.0 12384.3 12476.7 12953.5 11982.9 12299.6 12481.7 13054.2 13094.2 10252.3 10285.7 10376.7 10921.9 10923.1 10831.2 11045.8 11052.5 11142.5 11417.3 19:52:20 INFO - PROCESS | 27499 | -------- Summary: end -------- 19:52:20 INFO - PROCESS | 27499 | 19:52:20 INFO - TEST-INFO | 27499: exit 0 19:52:20 INFO - TEST-OK | dromaeo_css | took 1117411ms 19:52:20 INFO - TEST-START | kraken 19:52:20 INFO - operating with platform_type : linux_ 19:52:20 INFO - Initialising browser for kraken test... 19:52:20 INFO - TEST-INFO | started process 27803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAjThUv/profile http://localhost:45747/getInfo.html) 19:52:25 INFO - PROCESS | 27803 | __metrics Screen width/height:1600/1200 19:52:25 INFO - PROCESS | 27803 | colorDepth:24 19:52:25 INFO - PROCESS | 27803 | Browser inner width/height: 1024/697 19:52:25 INFO - PROCESS | 27803 | __metrics 19:52:25 INFO - PROCESS | 27803 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:52:25 INFO - PROCESS | 27803 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:52:26 INFO - PROCESS | 27803 | console.error: PushService: 19:52:26 INFO - PROCESS | 27803 | stateChangeProcessEnqueue: Error transitioning state 19:52:26 INFO - PROCESS | 27803 | UnknownError 19:52:26 INFO - TEST-INFO | 27803: exit 0 19:52:26 INFO - Browser initialized. 19:52:26 INFO - Running cycle 1/1 for kraken test... 19:52:26 INFO - TEST-INFO | started process 27888 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAjThUv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:52:39 INFO - PROCESS | 27888 | RSS: Main: 172175360 19:52:39 INFO - PROCESS | 27888 | 19:52:41 INFO - PROCESS | 27888 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45747/tests/kraken/driver.html?testName=audio-beat-detection) 19:52:42 INFO - PROCESS | 27888 | RSS: Main: 232886272 19:52:42 INFO - PROCESS | 27888 | 19:52:45 INFO - PROCESS | 27888 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45747/tests/kraken/driver.html?testName=audio-dft) 19:52:45 INFO - PROCESS | 27888 | RSS: Main: 216092672 19:52:45 INFO - PROCESS | 27888 | 19:52:48 INFO - PROCESS | 27888 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45747/tests/kraken/driver.html?testName=audio-fft) 19:52:49 INFO - PROCESS | 27888 | RSS: Main: 297529344 19:52:49 INFO - PROCESS | 27888 | 19:52:51 INFO - PROCESS | 27888 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45747/tests/kraken/driver.html?testName=audio-oscillator) 19:52:52 INFO - PROCESS | 27888 | RSS: Main: 205910016 19:52:52 INFO - PROCESS | 27888 | 19:52:54 INFO - PROCESS | 27888 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45747/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:52:54 INFO - PROCESS | 27888 | RSS: Main: 211861504 19:52:54 INFO - PROCESS | 27888 | 19:52:57 INFO - PROCESS | 27888 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45747/tests/kraken/driver.html?testName=imaging-darkroom) 19:52:58 INFO - PROCESS | 27888 | RSS: Main: 248143872 19:52:58 INFO - PROCESS | 27888 | 19:53:01 INFO - PROCESS | 27888 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45747/tests/kraken/driver.html?testName=imaging-desaturate) 19:53:02 INFO - PROCESS | 27888 | RSS: Main: 246677504 19:53:02 INFO - PROCESS | 27888 | 19:53:05 INFO - PROCESS | 27888 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45747/tests/kraken/driver.html?testName=json-parse-financial) 19:53:05 INFO - PROCESS | 27888 | RSS: Main: 245833728 19:53:05 INFO - PROCESS | 27888 | 19:53:07 INFO - PROCESS | 27888 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45747/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:53:07 INFO - PROCESS | 27888 | RSS: Main: 208564224 19:53:07 INFO - PROCESS | 27888 | 19:53:09 INFO - PROCESS | 27888 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45747/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:53:10 INFO - PROCESS | 27888 | RSS: Main: 215478272 19:53:10 INFO - PROCESS | 27888 | 19:53:12 INFO - PROCESS | 27888 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45747/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:53:12 INFO - PROCESS | 27888 | RSS: Main: 225644544 19:53:12 INFO - PROCESS | 27888 | 19:53:15 INFO - PROCESS | 27888 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:53:16 INFO - PROCESS | 27888 | RSS: Main: 234057728 19:53:16 INFO - PROCESS | 27888 | 19:53:18 INFO - PROCESS | 27888 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:53:19 INFO - PROCESS | 27888 | RSS: Main: 230760448 19:53:19 INFO - PROCESS | 27888 | 19:53:21 INFO - PROCESS | 27888 | Cycle 1(1): loaded http://localhost:45747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45747/tests/kraken/driver.html?testName=ai-astar) 19:53:21 INFO - PROCESS | 27888 | RSS: Main: 282542080 19:53:21 INFO - PROCESS | 27888 | 19:53:21 INFO - PROCESS | 27888 | __start_tp_report 19:53:21 INFO - PROCESS | 27888 | _x_x_mozilla_page_load 19:53:21 INFO - PROCESS | 27888 | _x_x_mozilla_page_load_details 19:53:21 INFO - PROCESS | 27888 | |i|pagename|runs| 19:53:21 INFO - PROCESS | 27888 | |0;ai-astar;107;111;121;111;110;111;110;111;110;110 19:53:21 INFO - PROCESS | 27888 | |1;audio-beat-detection;150;121;123;154;126;123;124;125;163;123 19:53:21 INFO - PROCESS | 27888 | |2;audio-dft;163;160;163;162;161;161;163;161;161;161 19:53:21 INFO - PROCESS | 27888 | |3;audio-fft;76;75;76;112;76;76;76;76;108;76 19:53:21 INFO - PROCESS | 27888 | |4;audio-oscillator;83;82;122;82;82;83;106;82;82;128 19:53:21 INFO - PROCESS | 27888 | |5;imaging-gaussian-blur;117;118;118;117;117;118;118;118;118;118 19:53:21 INFO - PROCESS | 27888 | |6;imaging-darkroom;145;146;145;146;146;147;146;146;146;145 19:53:21 INFO - PROCESS | 27888 | |7;imaging-desaturate;85;84;84;84;85;86;85;85;86;84 19:53:21 INFO - PROCESS | 27888 | |8;json-parse-financial;54;52;52;53;52;57;53;54;53;55 19:53:21 INFO - PROCESS | 27888 | |9;json-stringify-tinderbox;62;63;62;62;62;62;63;62;66;62 19:53:21 INFO - PROCESS | 27888 | |10;stanford-crypto-aes;80;88;82;84;80;79;79;84;81;78 19:53:21 INFO - PROCESS | 27888 | |11;stanford-crypto-ccm;130;134;132;131;142;130;130;140;179;138 19:53:21 INFO - PROCESS | 27888 | |12;stanford-crypto-pbkdf2;167;170;166;164;169;164;170;167;167;168 19:53:21 INFO - PROCESS | 27888 | |13;stanford-crypto-sha256-iterative;68;69;66;65;65;67;65;66;65;65 19:53:21 INFO - PROCESS | 27888 | __end_tp_report 19:53:21 INFO - PROCESS | 27888 | __start_cc_report 19:53:21 INFO - PROCESS | 27888 | _x_x_mozilla_cycle_collect,1673 19:53:21 INFO - PROCESS | 27888 | __end_cc_report 19:53:21 INFO - PROCESS | 27888 | __startTimestamp1477623201448__endTimestamp 19:53:21 INFO - PROCESS | 27888 | 19:53:21 INFO - PROCESS | 27888 | ------- Summary: start ------- 19:53:21 INFO - PROCESS | 27888 | Number of tests: 14 19:53:21 INFO - PROCESS | 27888 | 19:53:21 INFO - PROCESS | 27888 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:3.65 (3.3%) stddev-sans-first:3.54 19:53:21 INFO - PROCESS | 27888 | Values: 107.0 111.0 121.0 111.0 110.0 111.0 110.0 111.0 110.0 110.0 19:53:21 INFO - PROCESS | 27888 | 19:53:21 INFO - PROCESS | 27888 | [#1] audio-beat-detection Cycles:10 Average:133.20 Median:125.50 stddev:15.87 (12.6%) stddev-sans-first:15.63 19:53:21 INFO - PROCESS | 27888 | Values: 150.0 121.0 123.0 154.0 126.0 123.0 124.0 125.0 163.0 123.0 19:53:21 INFO - PROCESS | 27888 | 19:53:21 INFO - PROCESS | 27888 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.01 19:53:21 INFO - PROCESS | 27888 | Values: 163.0 160.0 163.0 162.0 161.0 161.0 163.0 161.0 161.0 161.0 19:53:21 INFO - PROCESS | 27888 | 19:53:21 INFO - PROCESS | 27888 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:14.42 (19.0%) stddev-sans-first:15.09 19:53:21 INFO - PROCESS | 27888 | Values: 76.0 75.0 76.0 112.0 76.0 76.0 76.0 76.0 108.0 76.0 19:53:21 INFO - PROCESS | 27888 | 19:53:21 INFO - PROCESS | 27888 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:82.00 stddev:18.38 (22.4%) stddev-sans-first:19.12 19:53:21 INFO - PROCESS | 27888 | Values: 83.0 82.0 122.0 82.0 82.0 83.0 106.0 82.0 82.0 128.0 19:53:21 INFO - PROCESS | 27888 | 19:53:21 INFO - PROCESS | 27888 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 19:53:21 INFO - PROCESS | 27888 | Values: 117.0 118.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 19:53:21 INFO - PROCESS | 27888 | 19:53:21 INFO - PROCESS | 27888 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 19:53:21 INFO - PROCESS | 27888 | Values: 145.0 146.0 145.0 146.0 146.0 147.0 146.0 146.0 146.0 145.0 19:53:21 INFO - PROCESS | 27888 | 19:53:21 INFO - PROCESS | 27888 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.79 (0.9%) stddev-sans-first:0.83 19:53:21 INFO - PROCESS | 27888 | Values: 85.0 84.0 84.0 84.0 85.0 86.0 85.0 85.0 86.0 84.0 19:53:21 INFO - PROCESS | 27888 | 19:53:21 INFO - PROCESS | 27888 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.50 stddev:1.58 (3.0%) stddev-sans-first:1.67 19:53:21 INFO - PROCESS | 27888 | Values: 54.0 52.0 52.0 53.0 52.0 57.0 53.0 54.0 53.0 55.0 19:53:21 INFO - PROCESS | 27888 | 19:53:21 INFO - PROCESS | 27888 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:62.00 stddev:1.26 (2.0%) stddev-sans-first:1.32 19:53:21 INFO - PROCESS | 27888 | Values: 62.0 63.0 62.0 62.0 62.0 62.0 63.0 62.0 66.0 62.0 19:53:21 INFO - PROCESS | 27888 | 19:53:21 INFO - PROCESS | 27888 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.50 stddev:3.06 (3.8%) stddev-sans-first:3.20 19:53:21 INFO - PROCESS | 27888 | Values: 80.0 88.0 82.0 84.0 80.0 79.0 79.0 84.0 81.0 78.0 19:53:21 INFO - PROCESS | 27888 | 19:53:21 INFO - PROCESS | 27888 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:136.00 stddev:14.87 (10.9%) stddev-sans-first:15.44 19:53:21 INFO - PROCESS | 27888 | Values: 130.0 134.0 132.0 131.0 142.0 130.0 130.0 140.0 179.0 138.0 19:53:21 INFO - PROCESS | 27888 | 19:53:21 INFO - PROCESS | 27888 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.20 Median:167.50 stddev:2.15 (1.3%) stddev-sans-first:2.28 19:53:21 INFO - PROCESS | 27888 | Values: 167.0 170.0 166.0 164.0 169.0 164.0 170.0 167.0 167.0 168.0 19:53:21 INFO - PROCESS | 27888 | 19:53:21 INFO - PROCESS | 27888 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:1.45 (2.2%) stddev-sans-first:1.36 19:53:21 INFO - PROCESS | 27888 | Values: 68.0 69.0 66.0 65.0 65.0 67.0 65.0 66.0 65.0 65.0 19:53:21 INFO - PROCESS | 27888 | -------- Summary: end -------- 19:53:21 INFO - PROCESS | 27888 | 19:53:22 INFO - TEST-INFO | 27888: exit 0 19:53:22 INFO - TEST-OK | kraken | took 61725ms 19:53:22 INFO - SUITE-END | took 1179s 19:53:23 INFO - Completed test suite (00:19:39) 19:53:23 INFO - javascript benchmark 19:53:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2923.970760292397, 2967.7774166937484, 2969.064744605449, 2980.1655536449775, 3025.8638361273743, 4996.525330093636, 5088.49115088491, 5208.505192006758, 5258.6581872178285, 5297.152455607099, 5185.585153187745, 5244.842654720364, 5335.5198032177095, 5358.24984502169, 5421.0, 4759.524047595248, 4771.308160316752, 4822.083804077231, 4849.903001939959, 4864.927026094611, 4839.78220980055, 4881.048195601859, 4886.853394398174, 4889.193283108283, 4938.580220681247, 4709.0, 4882.829100981484, 4886.315915771795, 4916.508349165073, 4995.35060442142, 4734.644901632391, 4806.831760888352, 4807.975960120212, 4819.325294458778, 4819.44576373718, 4704.129735998851, 4776.044791041805, 4782.593479554242, 4788.401449818773, 4789.329493870826, 5206.140986737184, 5255.395629502618, 5259.079661059338, 5307.01820163271, 5327.7336133193185, 5609.046462101453, 5609.467100625475, 5611.158326251095, 5617.129344951539, 5617.354004289518, 5407.324084489439, 5528.281323427969, 5669.291338582677, 5670.908240725054, 5726.398728133528, 5235.05768961583, 5237.292965449654, 5242.606804489678, 5247.055530004598, 5249.527542521191, 5641.915371269434, 5671.376148623648, 5677.829665110054, 5686.800961966312, 5689.886202275931, 5505.6696598204235, 5550.139728342114, 5552.278203833556, 5575.1915972184615, 5646.20953066571, 5655.604107712503, 5661.886762264814, 5662.433756624305, 5663.263775709132, 5666.688332141689, 5394.298741163702, 5609.298837645294, 5613.859653508695, 5621.297337832771, 5625.521830644359, 5477.04151773446, 5512.862178445571, 5542.334919809648, 5561.555075593943, 5638.210650508932, 4322.848700295474, 4323.156984388077, 4368.956310436918, 4377.124575084932, 4377.474703035656, 3838.0788610733225, 3838.251540949488, 3863.0, 3893.688504919656, 3910.2570511602703, 5190.6366554341585, 5244.29202057725, 5254.0805359062015, 5287.550558202596, 5294.57643388528, 5604.747786349624, 5647.661140331593, 5657.038303488334, 5679.943200567942, 5738.626989245686, 5331.413544510101, 5334.91997620036, 5338.119210330329, 5343.732813359316, 5346.251524786533, 4822.758862056883, 4937.580305673986, 4943.085529177042, 4948.480409557017, 5002.89994200114, 5744.856378590485, 5775.364709881909, 5795.1886735857015, 5832.883342333214, 5893.793717219876, 5596.580256480862, 5645.915311270416, 5647.548196144381, 5649.322081350264, 5694.373618901835, 5809.883802324014, 5860.179574859438, 5871.442212989759, 5875.853103672443, 5881.147233651182, 5323.334583177103, 5375.569954403716, 5481.643693159932, 5528.364238112668, 5568.777248909998, 5645.266115404971, 5648.943510564842, 5650.519705824887, 5672.2058911751565, 5715.142728590578, 5481.451854814487, 5519.558435325244, 5522.475364840334, 5523.226748255167, 5525.668459892419, 5385.623006389672, 5407.675539467645, 5449.836504904859, 5519.39286678457, 5584.972075139598, 5450.918236226539, 5511.834644960658, 5526.778928842801, 5582.637128586629, 5593.021221286177, 5555.30558680165, 5562.944370556243, 5565.443455654402, 5566.888662226814, 5573.665580065209, 5273.156294992783, 5324.121519949165, 5446.373667028342, 5457.099578569491, 5514.283143191359], "value": 5192.395117812022, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.7155650618183, 587.847159738468, 625.6558892609064, 626.1015442839524, 658.6245839871275, 31431.842840785794, 34283.65716342836, 34523.30953380937, 34532.0, 34546.309073818506, 34667.4799878002, 43108.56891431085, 44169.55830441695, 44319.77840110795, 47596.28605570919, 8691.695790647313, 8818.559072046372, 8820.294376449869, 8828.823423531525, 8831.205191532761, 8700.390972631918, 8787.604557794915, 8802.471851688919, 8804.735857924272, 8805.603747831363, 7980.960095199516, 8171.142030086845, 10445.582176712922, 10668.146548276158, 10678.78642427151, 10517.84223236652, 10550.314229575053, 10556.78886422275, 10563.313384629975, 10566.418846963375, 10535.84196237057, 10569.365838049665, 10580.36517808934, 10590.152787776959, 10590.205734569938, 41497.79251103755, 41548.376774348406, 41837.0, 41837.0, 41915.37126943098, 3495.196104895863, 3659.3413185626578, 3725.0, 3848.672862806665, 3954.8418063277436, 30950.226244343845, 31264.37471250585, 31483.527747083812, 31544.526832097537, 31593.21016974571, 4327.913441731148, 4328.9783551082355, 4471.351654010183, 4567.520410356931, 4576.977115114403, 323076.0, 323714.0, 324724.0, 325168.0, 326600.0, 56028.0, 56284.0, 56382.7180864093, 56393.0, 56446.0, 58346.831443597934, 58766.706166468895, 58783.70608146932, 58871.0, 59114.40885591175, 14626.853731462763, 14841.406343746345, 14841.480548180762, 14846.703065938837, 14849.703005940037, 10998.835017474745, 11047.613333533287, 11078.390688512209, 11082.22424430282, 11086.778264434666, 13935.930320348334, 14228.715425691635, 14829.406823727146, 15696.529104126894, 15791.921040394724, 6033.245844269466, 6293.118963345135, 6486.351364863476, 6505.381988711065, 6516.934830651633, 988.7874107067015, 992.4045572656493, 1020.2195320579763, 1044.3994703045628, 1111.4776055254017, 30753.846230768704, 30980.53529197064, 31097.844510777755, 31204.37591248208, 31628.209294767814, 1044.0759927464248, 1091.476091476096, 1095.6767753512734, 1118.6420345489528, 1120.5797825815318, 15819.288132034086, 16189.595260118356, 16294.0, 16456.506304810875, 16626.58433539171, 453258.0, 456752.0, 457049.0, 458082.0, 458846.0, 48702.75648621734, 49945.500544994815, 54449.1832622511, 58317.0, 59942.40057599456, 1299.9545015924587, 1316.5721140629335, 1332.7001424679563, 1339.9196048236943, 1356.3557310277736, 29787.0, 31525.211869703442, 31884.202894927814, 31922.84038579792, 32567.837160814044, 48897.511024889296, 49399.0, 49435.50564494309, 49491.0, 49519.81962615473, 431291.0, 438355.0, 439209.0, 598560.0, 600470.0, 26422.339441514116, 26469.735302647496, 26527.469450611265, 26754.0, 26809.597856032564, 45230.54769452395, 45526.54473455223, 46758.298625521325, 47285.52714472811, 47518.76240618775, 39271.0, 39318.0681931816, 39804.0, 41297.1740565193, 41333.0, 38864.0, 39227.803860980515, 39846.800765995984, 39926.401103982884, 41386.58613413827, 39812.2037559253, 39836.2032759349, 40958.385624215065, 41198.1760364785, 41212.58787412087, 31468.0, 35259.647403526666, 35487.82256088703, 36127.63872361243, 36200.818995904854, 26976.460470790866, 27419.314517136434, 27585.071678687553, 27699.446011079264, 27727.30681732892], "value": 19550.000796617143, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.2288194790941, 380.2262396024092, 390.3227899594203, 398.18372336709746, 418.7215501691375, 13369.863561597263, 14532.128072315669, 16060.91969540152, 19099.0, 19321.323753668625, 18168.182431790567, 18472.53818654531, 18648.34730784423, 18839.152238149283, 18862.62274754504, 5123.001014802106, 5300.867478313054, 5310.176922577007, 5318.30861987941, 5348.598855085884, 5058.544730974211, 5114.948850511503, 5706.3722990471015, 5785.768569257225, 5789.2763404574425, 5768.884622307552, 5771.913421298684, 5772.740226689809, 5775.768969241225, 5776.075827867542, 5113.105206588851, 5179.870503237412, 5189.221616757479, 5204.29741984831, 5214.739263036833, 4940.802367905316, 5068.898622027576, 5076.06092872816, 5079.060373830853, 5088.898222035538, 13968.650783730387, 15645.608859778597, 21369.145234190615, 22284.55430891373, 22395.888020559956, 2202.7466841313294, 2267.4218074391088, 2322.1408079010876, 2356.882155892216, 2587.702414222351, 9975.800483990351, 10004.449755263531, 10041.24690648197, 10531.157507399466, 10638.202134839918, 1876.352658332873, 1923.471045462495, 1928.4407521818655, 1929.2958070304237, 1933.4586315831589, 71750.0, 81566.0, 84846.0, 85450.57274713587, 87648.12351876464, 10804.0, 10892.40091794959, 10892.727681808019, 11229.775404491864, 11288.2662626929, 15515.146666933428, 15531.0, 15536.980192574892, 15537.68924621524, 15544.533663990098, 7369.963150184215, 7425.257474252639, 7712.5758083305955, 7753.0, 7898.842023159505, 7222.277772222736, 7225.349718525253, 7319.487635865545, 7348.52234604749, 7431.145418276968, 4572.95427045732, 4636.397268355092, 4657.604103651228, 4753.191957367256, 4836.347093142451, 1841.1530695880044, 1899.9620007600047, 1914.3012800328058, 1965.84273258139, 1977.1300627723756, 431.2948329481258, 437.79423670875275, 843.7932706486949, 974.3277138774223, 1026.7895081508273, 11121.332720036824, 11663.59177428786, 11852.88147118535, 11929.642110736691, 12424.56514022005, 454.62720569133654, 457.1611093643136, 467.6515995583312, 468.14797069333486, 474.50888330577686, 6283.3088360280335, 6351.0, 6359.7456101755415, 6418.775342862978, 6567.211934567882, 419484.0, 421867.0, 424041.0, 442923.0, 444556.0, 92889.0, 93075.53462232645, 94155.52922235482, 95232.52383738037, 100948.49525752325, 441.9027813880941, 442.48450555103585, 443.9533848945879, 445.13865669928146, 445.2875399360997, 10763.892361076601, 10807.459627018461, 10834.837477438003, 10902.672919812418, 11007.61473348429, 39557.60442395539, 40107.0, 40182.397264040475, 40474.39288410617, 41426.585734142274, 57183.42816571781, 57711.71144144252, 58042.4195758037, 59322.40677593169, 61039.38960610515, 8275.95862020686, 8337.333013359039, 8386.203310685476, 8619.1811777881, 8741.256993155654, 11571.537138514364, 12924.224546527239, 13019.544315948897, 13125.278109703677, 13186.670333241746, 11049.33703977764, 11068.501917413574, 11453.885461145283, 11539.365334906324, 11619.47712352963, 11371.545138194711, 11382.54469821198, 11437.485313160762, 11487.54049837997, 11723.765524689288, 11451.770964580495, 11687.707807304885, 11831.881681183422, 12050.75898482043, 12170.695732606755, 8539.231469167804, 11594.478248479007, 11881.762364752829, 12164.93917530442, 12432.937835311128, 11962.222455540363, 12488.562900298446, 12554.497820087094, 12558.93720531428, 12695.619131426072], "value": 8241.211253423779, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.0947665064407, 1438.2017980021092, 1485.598888300159, 1595.3857764760564, 1753.9210735516901, 7445.8883116753295, 8252.504849709021, 8355.916440835605, 8416.284615807665, 8647.524386158759, 8452.830943381145, 8508.787280317994, 8513.48919064855, 8519.659213631447, 8520.488770673765, 2275.283285764983, 2319.5360927814504, 2319.9188028419007, 2320.0835669910375, 2327.2203811723007, 2254.7632498587577, 2298.6781850540856, 2330.0, 2342.7188737351544, 2348.7064116985375, 2226.265332440299, 2279.133929106937, 2279.9772002280015, 2282.315305408379, 2287.7025986621716, 2262.66060090986, 2276.1236923784295, 2288.702468679078, 2294.162630639813, 2294.541091781642, 2226.6548684953696, 2277.271273192579, 2284.6801447797156, 2284.7029886114697, 2285.108807565051, 8565.871511927326, 8619.956900215459, 8637.481751094892, 8638.17937295956, 8644.351673624504, 5059.772310246048, 5086.364204474404, 5201.921971170435, 5211.869703257411, 5239.13554263546, 3297.9010629681147, 3527.382708026111, 3564.2515071834687, 3607.080194550399, 3610.3501369753435, 1086.9239153259275, 1149.3448734221497, 1245.8446886885647, 1256.8994480441634, 2147.688585155159, 11848.407579620984, 12004.459799309052, 12020.33888136161, 12021.39893005355, 12024.218425802383, 4421.7789110544345, 4440.7335559866515, 4454.28731402974, 4491.483479399845, 4496.820127194941, 9369.0, 9370.718878433521, 9375.249980001583, 9376.859347109663, 9378.90621093794, 5034.244863270539, 5034.395872495324, 5055.570276526537, 5064.949350506447, 5073.188289873602, 3927.2145570885937, 4093.242750091183, 4270.231358355463, 4670.7664616769025, 4745.6440766942615, 3615.584207816082, 3633.218857945554, 3711.387621042498, 3735.122246272124, 3758.567764707039, 1148.8219326004482, 1169.4564322598314, 1172.8240763885485, 1189.1972918280298, 1191.142377488207, 842.2251528593708, 851.0680804519042, 870.8373972411881, 926.1895841139003, 929.2380248196549, 5563.749631266603, 5716.885662286731, 5817.127430885401, 5824.708764561755, 5952.0476723724, 840.3949156607233, 858.2233079063458, 882.3558802074522, 883.9779005524913, 921.1617428140494, 3726.06848287928, 3810.5046343975105, 3867.7099217558793, 3927.0575061985487, 3997.980010099931, 10412.739681507872, 10783.352998819939, 10808.78382432347, 10874.728131796768, 10877.129829613612, 10721.731956700989, 10733.677989660322, 10753.354798712102, 10753.83869241962, 10775.676729698122, 7718.807029824299, 8012.959935200403, 8029.0, 8223.794405139919, 8231.42380033404, 5426.728663566727, 5477.068898287381, 5722.828315150552, 5772.0, 5878.2064421302575, 9381.85927211106, 9786.217102631916, 9827.164691001344, 9834.311598188058, 9867.901320986699, 9913.702588922344, 10048.397096174253, 10048.648297309559, 10143.34068285559, 10203.18374530021, 7715.614219289126, 7819.100803407453, 7840.098388685375, 7895.328897043815, 7919.366450684047, 8302.54336011525, 8311.418200726133, 8352.373571982003, 8391.286740627114, 8401.915980840358, 7449.776506704591, 7529.698812047457, 7551.0, 7560.243975602396, 7653.502522336031, 7316.926830731624, 7384.040074790243, 7389.852202956018, 7476.663550140148, 7568.205338439385, 6561.540692151503, 6686.0973768540625, 6713.530052896251, 6730.427913627396, 6731.48541578141, 4927.975360123177, 5020.623453240948, 5037.596992240538, 5058.54473097423, 5250.684958902478, 5138.948610513847, 5191.195364718475, 5199.974000129975, 5266.183741520071, 5401.648892821954], "value": 4525.65248671133, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.92503724143444, 330.7684620765464, 338.08716465543023, 341.9367417027852, 342.36149581031367, 5029.874253143673, 5087.720175390352, 5127.641065125443, 5241.816536421226, 5246.711430871305, 4996.67521611095, 5111.7699703513335, 5111.948880511194, 5140.2546630738525, 5146.356705411824, 4079.796010199493, 4087.4277601135864, 4088.7751173685438, 4089.427480152781, 4104.199681062194, 3811.6760075393486, 3827.0623697194087, 4098.4876890388705, 4108.5686002969705, 4121.743822380331, 4044.5550989391145, 4048.554658987509, 4062.2281766464425, 4063.3701776224734, 4074.775887326196, 4045.63589276965, 4049.6760259179196, 4056.1482088761395, 4057.8376864925367, 4062.4718786557855, 3626.1116026573395, 3631.110377957391, 3633.745637805355, 3649.6350364963555, 3654.689351405107, 4855.543336998921, 4977.705796492902, 5005.199168133117, 5026.623003274769, 5065.898682026339, 4651.0, 4657.115148121846, 4663.393758811367, 4672.836450724209, 4701.717896926195, 5372.516473517363, 5373.838784836461, 5378.408375078739, 5391.975524650343, 5427.914417116593, 3711.645249483946, 3885.8445662173763, 3888.591697871739, 3889.8444062237477, 3896.811472500886, 5568.9443105569235, 5573.721313934328, 5579.553635709133, 5585.497305242548, 5600.18797274397, 3962.9405558916637, 3964.207158568298, 3974.20515896816, 3991.1419044904906, 3992.321305378093, 3943.546492153439, 3998.300297447993, 4016.758994460342, 4019.9196016079513, 4045.7370270932297, 4552.6130278926, 4559.772011399416, 4566.328697711876, 4577.725336479822, 4579.7252164870215, 5361.195820626859, 5371.435999220103, 5376.623636345496, 5380.569554435636, 5389.299391079135, 1286.035473394954, 1301.4208677138772, 1363.9590812275649, 1371.1019282370064, 1394.958151255464, 872.3457406944791, 882.3911501064246, 893.9106089391139, 897.8742975983367, 899.9325050621229, 4554.749488778149, 4566.46099273066, 4572.268437050123, 4608.400907882021, 4611.331356953223, 4809.9038019239415, 4833.32333473314, 4834.299026641117, 4840.419149702058, 4840.636952228597, 4551.544845515422, 4566.196352440767, 4601.0, 4630.583247507673, 4651.325522811785, 2447.5961466357853, 2557.7698007179442, 2601.2586412872242, 2622.0858773095747, 2622.895084196649, 5005.8486548093415, 5028.547430731252, 5034.723090230073, 5042.823501177441, 5106.974465127651, 4843.515648435128, 4845.563899249085, 4886.975565122223, 4934.309196712463, 4936.605071594264, 5297.986765029341, 5799.5070419014855, 5809.593328466966, 5825.563082768725, 5830.329512106162, 5524.226608274925, 5546.58400619947, 5547.55619550443, 5573.665580065047, 5575.219469274386, 5414.648047876875, 5466.91799623014, 5496.862578435571, 5526.281583394133, 5547.669978608913, 5780.913286300793, 5781.335146458211, 5784.82645520635, 5786.681732504752, 5821.738021788945, 3957.4459575660007, 3974.6621537169663, 3983.7012224083887, 3986.202759448064, 3991.680665546807, 5229.954009198252, 5266.947330526646, 5488.204210389551, 5509.724513774215, 5584.888302234014, 5256.294312509748, 5274.578033757213, 5416.864578385572, 5420.728963551728, 5425.755840987244, 5413.864653383697, 5418.295621569171, 5426.918596220981, 5430.67415955044, 5431.158170483582, 5280.234366016983, 5370.194470829407, 5391.708523877415, 5394.649347792538, 5406.702631355313, 5385.226608296652, 5394.190871369326, 5400.486953739389, 5425.918611220914, 5430.647007944471, 5259.106721580151, 5297.516695325315, 5297.8145764898045, 5302.549283310807, 5310.7875684973715], "value": 4041.3493175937365, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.2906851048355, 764.9770506884795, 774.8400218264794, 783.843231353729, 810.9310708589769, 12654.873451265485, 13103.624119467462, 13456.259905705183, 14168.504102356419, 14412.135271883695, 12298.938505307484, 12401.627951161458, 12429.564965226218, 12433.502659893593, 12435.502579896816, 781.4022272961175, 804.1917872538091, 808.8665370213907, 815.6778072661295, 816.4488969945263, 674.4873895839173, 696.2271878215178, 781.9413543984195, 812.1796985045117, 816.5345752920838, 853.2363534636496, 854.9572521373938, 863.0161615758041, 863.22741146674, 863.5078005536847, 853.6713365354352, 859.9054104048549, 860.694453469022, 860.9913900860973, 861.5089399042548, 511.53961434708685, 524.847794139699, 597.9342272350038, 629.2669040567733, 629.6411045703951, 13110.082294239408, 13690.315484225748, 13706.246156461391, 13726.794098088536, 13740.0, 13838.169709817343, 14138.929305353511, 14571.70856582873, 14608.926955365261, 14637.341319640534, 12806.80789788154, 12854.164479308814, 13060.86939130606, 13083.803742943863, 13285.800712989312, 4498.460184777848, 4549.431321084864, 4569.565891240327, 4619.053094115732, 4798.832040878588, 71400.66051115197, 72388.63805680991, 73331.63334183295, 73735.0, 73918.63040684815, 11470.942645286721, 11516.654500365003, 11559.653210403701, 11609.477573509212, 11655.242409243372, 20887.68668469974, 21197.25809596657, 21647.13411463524, 21786.564268714537, 21880.124795008338, 7907.881381779278, 8034.196580341919, 8074.0, 8113.675452981933, 8336.374771892133, 4568.383268258809, 4571.428571428572, 4576.473705523841, 4594.977025114853, 4629.166749985035, 3259.1689119274433, 3360.5295258663805, 3366.5791776027995, 3375.4093033719, 3393.253484233514, 585.2508788750406, 594.111802854735, 598.7067933264216, 599.3437186281016, 599.9190109335271, 642.6080091144398, 645.8611398549334, 668.518666560076, 681.5399605266425, 684.5618803965466, 8350.540720260322, 8566.871496927552, 8851.380403371832, 8915.197632213132, 8997.775055623531, 629.3077614623969, 641.7914177892204, 659.6240143118376, 669.1167658690579, 682.3756263019282, 4055.513338399411, 4185.979070104691, 4194.412782210493, 4235.195312890541, 4336.891577710582, 85191.0, 88790.0, 90181.54909225412, 92069.0, 92237.0776292242, 66388.0, 68133.65933170401, 74812.0, 81385.59307203426, 82100.58949705213, 41531.58468415398, 50722.985540288246, 62011.0, 64192.67903660452, 65595.0, 8241.50550966944, 8656.48061116335, 8755.080716524928, 8827.514486703036, 8875.955620221857, 31986.68013319837, 32523.0, 40284.39573406343, 42796.0, 43063.56936430596, 58686.0, 60388.0, 60796.0, 63666.0, 64129.67935160294, 10048.296619236875, 10061.144802691853, 10580.947095264475, 10894.782104358026, 11089.722756931142, 12490.188137771016, 12697.111202215756, 12765.0, 13466.730665386833, 13529.59411217665, 12560.685982850502, 12714.809277860655, 13081.345932703136, 13222.537211197561, 13567.728645427234, 11982.700432489257, 12372.0, 12384.256944583354, 12476.688082798002, 12953.481860725466, 11982.940085299517, 12299.631011069681, 12481.687957801129, 13054.216746995211, 13094.214347139203, 10252.282340236112, 10285.702971865143, 10376.740581485523, 10921.890781092088, 10923.126149908147, 10831.187660925305, 11045.779084418105, 11052.502637381176, 11142.498587563417, 11417.31496110236], "value": 6961.251576246235, "unit": "score"}], "name": "dromaeo_css", "value": 6885.059979927044, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 121.0, 111.0, 110.0, 111.0, 110.0, 111.0, 110.0, 110.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 121.0, 123.0, 154.0, 126.0, 123.0, 124.0, 125.0, 163.0, 123.0], "value": 133.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 163.0, 162.0, 161.0, 161.0, 163.0, 161.0, 161.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 112.0, 76.0, 76.0, 76.0, 76.0, 108.0, 76.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 122.0, 82.0, 82.0, 83.0, 106.0, 82.0, 82.0, 128.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 85.0, 86.0, 85.0, 85.0, 86.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 52.0, 53.0, 52.0, 57.0, 53.0, 54.0, 53.0, 55.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 66.0, 62.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 88.0, 82.0, 84.0, 80.0, 79.0, 79.0, 84.0, 81.0, 78.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 134.0, 132.0, 131.0, 142.0, 130.0, 130.0, 140.0, 179.0, 138.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 170.0, 166.0, 164.0, 169.0, 164.0, 170.0, 167.0, 167.0, 168.0], "value": 167.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 66.0, 65.0, 65.0, 67.0, 65.0, 66.0, 65.0, 65.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1499.6999999999998, "alertThreshold": 2.0}]} 19:53:23 INFO - Return code: 0 19:53:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:53:23 INFO - # TBPL SUCCESS # 19:53:23 INFO - Running post-action listener: _resource_record_post_action 19:53:23 INFO - [mozharness: 2016-10-28 02:53:23.267883Z] Finished run-tests step (success) 19:53:23 INFO - Running post-run listener: _resource_record_post_run 19:53:23 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391610368; Read time: 12; Write time: 262084 19:53:23 INFO - TinderboxPrint: CPU usage
13.1% 19:53:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 19:53:23 INFO - TinderboxPrint: I/O write bytes / time
391,610,368 / 262,084 19:53:23 INFO - TinderboxPrint: CPU idle
8,301.4 (86.9%) 19:53:23 INFO - TinderboxPrint: CPU user
1,199.0 (12.6%) 19:53:23 INFO - TinderboxPrint: Swap in / out
0 / 0 19:53:23 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103432192; Read time: 0; Write time: 83544 19:53:23 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 287703040; Read time: 0; Write time: 178504 19:53:23 INFO - Running post-run listener: _upload_blobber_files 19:53:23 INFO - Blob upload gear active. 19:53:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:53:23 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 19:53:23 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'] 19:53:23 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 19:53:24 INFO - (blobuploader) - INFO - Open directory for files ... 19:53:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:53:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:53:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:53:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:53:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:53:27 INFO - (blobuploader) - INFO - Done attempting. 19:53:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:53:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:53:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:53:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:53:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:53:28 INFO - (blobuploader) - INFO - Done attempting. 19:53:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:53:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:53:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:53:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:53:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:53:29 INFO - (blobuploader) - INFO - Done attempting. 19:53:29 INFO - (blobuploader) - INFO - Iteration through files over. 19:53:29 INFO - Return code: 0 19:53:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:53:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:53:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fde1c7b8cc5539d6b688365805f1be5184ad354ba26275d3943b5139fb476457e80176ce1fdb129eab53f2ad4ecf22cf019df5c508c3bd7039d18fb44eb4293", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e00e729f9a1494507722c63915ee4b37bcc7e5bce76fe7c6735263adc8ef89bac953d9f26a4200a05cd5316c2b52903662053e784686e5f30f30c09753c9be26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0af2a77aa00f090293285b97c6ac67d52461e997285db370fbf198c0de1c64c078d09f97737b3ef1b76be77734c2cfe3efa7d7a146078062f634e35e5d032abd"} 19:53:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:53:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:53:29 INFO - Contents: 19:53:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fde1c7b8cc5539d6b688365805f1be5184ad354ba26275d3943b5139fb476457e80176ce1fdb129eab53f2ad4ecf22cf019df5c508c3bd7039d18fb44eb4293", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e00e729f9a1494507722c63915ee4b37bcc7e5bce76fe7c6735263adc8ef89bac953d9f26a4200a05cd5316c2b52903662053e784686e5f30f30c09753c9be26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0af2a77aa00f090293285b97c6ac67d52461e997285db370fbf198c0de1c64c078d09f97737b3ef1b76be77734c2cfe3efa7d7a146078062f634e35e5d032abd"} 19:53:29 INFO - Running post-run listener: copy_logs_to_upload_dir 19:53:29 INFO - Copying logs to upload dir... 19:53:29 INFO - mkdir: /builds/slave/test/build/upload/logs 19:53:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.347699 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-10-27 19:53:29.125725) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 19:53:29.129698) ========= 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=03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fde1c7b8cc5539d6b688365805f1be5184ad354ba26275d3943b5139fb476457e80176ce1fdb129eab53f2ad4ecf22cf019df5c508c3bd7039d18fb44eb4293", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e00e729f9a1494507722c63915ee4b37bcc7e5bce76fe7c6735263adc8ef89bac953d9f26a4200a05cd5316c2b52903662053e784686e5f30f30c09753c9be26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0af2a77aa00f090293285b97c6ac67d52461e997285db370fbf198c0de1c64c078d09f97737b3ef1b76be77734c2cfe3efa7d7a146078062f634e35e5d032abd"} build_url:https://queue.taskcluster.net/v1/task/Shx0CdtGSeWCpiJr7hBmWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011252 build_url: 'https://queue.taskcluster.net/v1/task/Shx0CdtGSeWCpiJr7hBmWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fde1c7b8cc5539d6b688365805f1be5184ad354ba26275d3943b5139fb476457e80176ce1fdb129eab53f2ad4ecf22cf019df5c508c3bd7039d18fb44eb4293", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e00e729f9a1494507722c63915ee4b37bcc7e5bce76fe7c6735263adc8ef89bac953d9f26a4200a05cd5316c2b52903662053e784686e5f30f30c09753c9be26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0af2a77aa00f090293285b97c6ac67d52461e997285db370fbf198c0de1c64c078d09f97737b3ef1b76be77734c2cfe3efa7d7a146078062f634e35e5d032abd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 19:53:29.157764) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 19:53:29.158129) ========= 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=03627c79f6bb3d1578c4a402000001ba-1477620671.524644-847385770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.34 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 19:53:29.500693) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 19:53:29.501004) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 19:53:29.501468) ========= ========= Total master_lag: 0.45 =========