builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-012 starttime: 1476271514.95 results: success (0) buildid: 20161012030247 builduid: 376fbef5f1834b3cbf068b4135d8dbb1 revision: aa8629a25ab5aeb2678a0187e50336659d368b44 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 04:25:14.947000) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 04:25:14.947848) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 04:25:14.948131) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 04:25:14.997047) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:25:14.997338) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-12 04:25:15-- 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% 46.3M=0s 2016-10-12 04:25:15 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090402 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:25:15.108919) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:25:15.109273) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021254 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:25:15.160304) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:25:15.160648) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev aa8629a25ab5aeb2678a0187e50336659d368b44 --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 aa8629a25ab5aeb2678a0187e50336659d368b44 --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=2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-12 04:25:16,002 truncating revision to first 12 chars 2016-10-12 04:25:16,002 Setting DEBUG logging. 2016-10-12 04:25:16,002 attempt 1/10 2016-10-12 04:25:16,002 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/aa8629a25ab5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 04:25:16,312 unpacking tar archive at: mozilla-central-aa8629a25ab5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643370 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:25:15.818039) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 04:25:15.818345) ========= script_repo_revision: aa8629a25ab5aeb2678a0187e50336659d368b44 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 04:25:15.818753) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 04:25:15.819019) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 04:25:15.829259) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-12 04:25:15.829812) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:25:16 INFO - MultiFileLogger online at 20161012 04:25:16 in /builds/slave/test 04:25:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:25:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:25:16 INFO - {'append_to_log': False, 04:25:16 INFO - 'base_work_dir': '/builds/slave/test', 04:25:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:25:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:25:16 INFO - 'branch': 'Firefox-Non-PGO', 04:25:16 INFO - 'buildbot_json_path': 'buildprops.json', 04:25:16 INFO - 'config_files': ('talos/linux_config.py',), 04:25:16 INFO - 'default_actions': ('clobber', 04:25:16 INFO - 'read-buildbot-config', 04:25:16 INFO - 'download-and-extract', 04:25:16 INFO - 'populate-webroot', 04:25:16 INFO - 'create-virtualenv', 04:25:16 INFO - 'install', 04:25:16 INFO - 'run-tests'), 04:25:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:25:16 INFO - 'download_minidump_stackwalk': True, 04:25:16 INFO - 'download_symbols': 'ondemand', 04:25:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:25:16 INFO - 'tooltool.py': '/tools/tooltool.py', 04:25:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:25:16 INFO - '/tools/misc-python/virtualenv.py')}, 04:25:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:25:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:25:16 INFO - 'installer_path': 'installer.exe', 04:25:16 INFO - 'log_level': 'info', 04:25:16 INFO - 'log_name': 'talos', 04:25:16 INFO - 'log_to_console': True, 04:25:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:25:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:25:16 INFO - 'opt_config_files': (), 04:25:16 INFO - 'pip_index': False, 04:25:16 INFO - 'sps_profile': False, 04:25:16 INFO - 'sps_profile_interval': 0, 04:25:16 INFO - 'suite': 'dromaeojs', 04:25:16 INFO - 'system_bits': '32', 04:25:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:25:16 INFO - 'title': 'talos-linux64-ix-012', 04:25:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:25:16 INFO - 'use_talos_json': True, 04:25:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:25:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:25:16 INFO - 'work_dir': 'build'} 04:25:16 INFO - [mozharness: 2016-10-12 11:25:16.772226Z] Running clobber step. 04:25:16 INFO - Running pre-action listener: _resource_record_pre_action 04:25:16 INFO - Running main action method: clobber 04:25:16 INFO - rmtree: /builds/slave/test/build 04:25:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:25:17 INFO - Running post-action listener: _resource_record_post_action 04:25:17 INFO - [mozharness: 2016-10-12 11:25:17.239070Z] Finished clobber step (success) 04:25:17 INFO - [mozharness: 2016-10-12 11:25:17.239170Z] Running read-buildbot-config step. 04:25:17 INFO - Running pre-action listener: _resource_record_pre_action 04:25:17 INFO - Running main action method: read_buildbot_config 04:25:17 INFO - Using buildbot properties: 04:25:17 INFO - { 04:25:17 INFO - "project": "", 04:25:17 INFO - "product": "firefox", 04:25:17 INFO - "script_repo_revision": "production", 04:25:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:25:17 INFO - "repository": "", 04:25:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:25:17 INFO - "buildid": "20161012030247", 04:25:17 INFO - "pgo_build": "False", 04:25:17 INFO - "basedir": "/builds/slave/test", 04:25:17 INFO - "buildnumber": 667, 04:25:17 INFO - "slavename": "talos-linux64-ix-012", 04:25:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:25:17 INFO - "platform": "ubuntu64_hw", 04:25:17 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:25:17 INFO - "branch": "mozilla-central", 04:25:17 INFO - "repo_path": "mozilla-central", 04:25:17 INFO - "revision": "aa8629a25ab5aeb2678a0187e50336659d368b44", 04:25:17 INFO - "stage_platform": "linux64", 04:25:17 INFO - "builduid": "376fbef5f1834b3cbf068b4135d8dbb1", 04:25:17 INFO - "slavebuilddir": "test" 04:25:17 INFO - } 04:25:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/d8F0IIknSh2rAc6bVY6TPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:25:17 INFO - Running post-action listener: _resource_record_post_action 04:25:17 INFO - [mozharness: 2016-10-12 11:25:17.241616Z] Finished read-buildbot-config step (success) 04:25:17 INFO - [mozharness: 2016-10-12 11:25:17.241704Z] Running download-and-extract step. 04:25:17 INFO - Running pre-action listener: _resource_record_pre_action 04:25:17 INFO - Running main action method: download_and_extract 04:25:17 INFO - mkdir: /builds/slave/test/build/tests 04:25:17 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')]} 04:25:17 INFO - trying https://queue.taskcluster.net/v1/task/d8F0IIknSh2rAc6bVY6TPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:25:17 INFO - Downloading https://queue.taskcluster.net/v1/task/d8F0IIknSh2rAc6bVY6TPA/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 04:25:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d8F0IIknSh2rAc6bVY6TPA/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 04:25:17 INFO - Downloaded 1361 bytes. 04:25:17 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:25:17 INFO - Using the following test package requirements: 04:25:17 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:25:17 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:25:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:25:17 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:25:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:25:17 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:25:17 INFO - u'jsshell-linux-x86_64.zip'], 04:25:17 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:25:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:25:17 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:25:17 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:25:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:25:17 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:25:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:25:17 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:25:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:25:17 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:25:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:25:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:25:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d8F0IIknSh2rAc6bVY6TPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:25:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d8F0IIknSh2rAc6bVY6TPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:25:17 INFO - Fetch https://queue.taskcluster.net/v1/task/d8F0IIknSh2rAc6bVY6TPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:25:18 INFO - Http code: 200 04:25:18 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 04:25:18 INFO - x-amz-cf-id: NuNYcF3XnAgGFOPt4g5Mw1CvPlcKDT3n-VS5uSa0siNDHY5g9ZS5ew== 04:25:18 INFO - x-amz-version-id: 5ZYy0rAMK_pY1Mc4nr6pMYofjtNejKUd 04:25:18 INFO - Expected file size: 20547369 04:25:18 INFO - Obtained file size: 20547369 04:25:22 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 04:25:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d8F0IIknSh2rAc6bVY6TPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:25:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d8F0IIknSh2rAc6bVY6TPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:25:22 INFO - Fetch https://queue.taskcluster.net/v1/task/d8F0IIknSh2rAc6bVY6TPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:25:23 INFO - Http code: 200 04:25:23 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 04:25:23 INFO - x-amz-cf-id: Xh27RYz41UyTgtp5huTBRkytchycaKE7qtVb4zePP4ZymeMelSPVLg== 04:25:23 INFO - x-amz-version-id: 5ZYy0rAMK_pY1Mc4nr6pMYofjtNejKUd 04:25:23 INFO - Expected file size: 20547369 04:25:23 INFO - Obtained file size: 20547369 04:25:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d8F0IIknSh2rAc6bVY6TPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:25:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d8F0IIknSh2rAc6bVY6TPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:25:27 INFO - Fetch https://queue.taskcluster.net/v1/task/d8F0IIknSh2rAc6bVY6TPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:25:28 INFO - Http code: 200 04:25:28 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 04:25:28 INFO - x-amz-cf-id: bQZGPWAvVRjBBOpzwrHaCoX5XkehAOBBujP-lSem11vdqoBrfEbd9w== 04:25:28 INFO - x-amz-version-id: cFtxKWjKvlFNCYt3cOZoD8ngXWmwb6oh 04:25:29 INFO - Expected file size: 14409006 04:25:29 INFO - Obtained file size: 14409006 04:25:29 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')]} 04:25:29 INFO - trying https://queue.taskcluster.net/v1/task/d8F0IIknSh2rAc6bVY6TPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:25:29 INFO - Downloading https://queue.taskcluster.net/v1/task/d8F0IIknSh2rAc6bVY6TPA/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 04:25:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d8F0IIknSh2rAc6bVY6TPA/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 04:25:31 INFO - Downloaded 55938545 bytes. 04:25:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d8F0IIknSh2rAc6bVY6TPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:25:31 INFO - mkdir: /builds/slave/test/properties 04:25:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:25:31 INFO - Writing to file /builds/slave/test/properties/build_url 04:25:31 INFO - Contents: 04:25:31 INFO - build_url:https://queue.taskcluster.net/v1/task/d8F0IIknSh2rAc6bVY6TPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:25:31 INFO - Running post-action listener: _resource_record_post_action 04:25:31 INFO - Running post-action listener: set_extra_try_arguments 04:25:31 INFO - [mozharness: 2016-10-12 11:25:31.745091Z] Finished download-and-extract step (success) 04:25:31 INFO - [mozharness: 2016-10-12 11:25:31.745315Z] Running populate-webroot step. 04:25:31 INFO - Running pre-action listener: _resource_record_pre_action 04:25:31 INFO - Running main action method: populate_webroot 04:25:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:25:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:25:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:25:31 INFO - '--tppagecycles', 04:25:31 INFO - '7'], 04:25:31 INFO - 'tests': ['tsvgm']}}, 04:25:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:25:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:25:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:25:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:25:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:25:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:25:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:31 INFO - 'talos_options': ['--disable-e10s'], 04:25:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:31 INFO - 'talos_options': ['--disable-e10s'], 04:25:31 INFO - 'tests': ['damp', 'tps']}, 04:25:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:31 INFO - 'tests': ['damp', 'tps']}, 04:25:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:25:31 INFO - 'tests': ['dromaeo_dom']}, 04:25:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:25:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:25:31 INFO - 'tests': ['basic_compositor_video']}, 04:25:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:25:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:25:31 INFO - 'tests': ['a11yr', 04:25:31 INFO - 'ts_paint', 04:25:31 INFO - 'tpaint', 04:25:31 INFO - 'sessionrestore', 04:25:31 INFO - 'sessionrestore_no_auto_restore', 04:25:31 INFO - 'tabpaint']}, 04:25:31 INFO - 'other-e10s': {'tests': ['a11yr', 04:25:31 INFO - 'ts_paint', 04:25:31 INFO - 'tpaint', 04:25:31 INFO - 'sessionrestore', 04:25:31 INFO - 'sessionrestore_no_auto_restore', 04:25:31 INFO - 'tabpaint']}, 04:25:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:25:31 INFO - 'ts_paint', 04:25:31 INFO - 'tpaint', 04:25:31 INFO - 'sessionrestore', 04:25:31 INFO - 'sessionrestore_no_auto_restore', 04:25:31 INFO - 'tabpaint']}, 04:25:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:25:31 INFO - 'ts_paint', 04:25:31 INFO - 'tpaint', 04:25:31 INFO - 'sessionrestore', 04:25:31 INFO - 'sessionrestore_no_auto_restore', 04:25:31 INFO - 'tabpaint']}, 04:25:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:25:31 INFO - 'tests': ['a11yr', 04:25:31 INFO - 'ts_paint', 04:25:31 INFO - 'tpaint', 04:25:31 INFO - 'sessionrestore', 04:25:31 INFO - 'sessionrestore_no_auto_restore', 04:25:31 INFO - 'tabpaint']}, 04:25:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:25:31 INFO - 'tests': ['a11yr', 04:25:31 INFO - 'ts_paint', 04:25:31 INFO - 'tpaint', 04:25:31 INFO - 'sessionrestore', 04:25:31 INFO - 'sessionrestore_no_auto_restore', 04:25:31 INFO - 'tabpaint']}, 04:25:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:25:31 INFO - 'tests': ['tsvgx', 04:25:31 INFO - 'tsvgr_opacity', 04:25:31 INFO - 'tart', 04:25:31 INFO - 'tscrollx', 04:25:31 INFO - 'cart']}, 04:25:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:25:31 INFO - 'tsvgr_opacity', 04:25:31 INFO - 'tart', 04:25:31 INFO - 'tscrollx', 04:25:31 INFO - 'cart']}, 04:25:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:31 INFO - 'talos_options': ['--disable-e10s'], 04:25:31 INFO - 'tests': ['tp5o']}, 04:25:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:31 INFO - 'tests': ['tp5o']}, 04:25:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:31 INFO - 'talos_options': ['--disable-e10s', 04:25:31 INFO - '--xperf_path', 04:25:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:31 INFO - 'tests': ['tp5n']}, 04:25:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:31 INFO - 'talos_options': ['--xperf_path', 04:25:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:31 INFO - 'tests': ['tp5n']}}, 04:25:31 INFO - 'talos.zip': {'path': '', 04:25:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:25:31 INFO - Running post-action listener: _resource_record_post_action 04:25:31 INFO - [mozharness: 2016-10-12 11:25:31.767763Z] Finished populate-webroot step (success) 04:25:31 INFO - [mozharness: 2016-10-12 11:25:31.767853Z] Running create-virtualenv step. 04:25:31 INFO - Running pre-action listener: _resource_record_pre_action 04:25:31 INFO - Running main action method: create_virtualenv 04:25:31 INFO - Creating virtualenv /builds/slave/test/build/venv 04:25:31 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 04:25:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:25:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:25:31 INFO - Using real prefix '/usr' 04:25:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:25:32 INFO - Installing distribute.............................................................................................................................................................................................done. 04:25:34 INFO - Installing pip.................done. 04:25:34 INFO - Return code: 0 04:25:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:25:34 INFO - Reading from file tmpfile_stdout 04:25:34 INFO - Output received: 04:25:34 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) 04:25:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:25:34 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')]} 04:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:34 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')]} 04:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:34 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 0x7f769c20af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d66f60>, '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 0x1d67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d681d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331', '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 04:25:34 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 04:25:34 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 04:25:34 INFO - Using env: {'DISPLAY': ':0', 04:25:34 INFO - 'HOME': '/home/cltbld', 04:25:34 INFO - 'LANG': 'en_US.UTF-8', 04:25:34 INFO - 'LANGUAGE': 'en_US:en', 04:25:34 INFO - 'LOGNAME': 'cltbld', 04:25:34 INFO - 'MAIL': '/var/mail/cltbld', 04:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:34 INFO - 'MOZ_NO_REMOTE': '1', 04:25:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:34 INFO - 'NO_EM_RESTART': '1', 04:25:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:34 INFO - 'PWD': '/builds/slave/test', 04:25:34 INFO - 'SHELL': '/bin/bash', 04:25:34 INFO - 'SHLVL': '1', 04:25:34 INFO - 'TERM': 'linux', 04:25:34 INFO - 'TMOUT': '86400', 04:25:34 INFO - 'USER': 'cltbld', 04:25:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331', 04:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:34 INFO - '_': '/tools/buildbot/bin/python'} 04:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:34 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 04:25:34 INFO - Cleaning up... 04:25:34 INFO - Return code: 0 04:25:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:25:34 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')]} 04:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:34 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')]} 04:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:34 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 0x7f769c20af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d66f60>, '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 0x1d67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d681d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331', '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 04:25:34 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 04:25:34 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 04:25:34 INFO - Using env: {'DISPLAY': ':0', 04:25:34 INFO - 'HOME': '/home/cltbld', 04:25:34 INFO - 'LANG': 'en_US.UTF-8', 04:25:34 INFO - 'LANGUAGE': 'en_US:en', 04:25:34 INFO - 'LOGNAME': 'cltbld', 04:25:34 INFO - 'MAIL': '/var/mail/cltbld', 04:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:34 INFO - 'MOZ_NO_REMOTE': '1', 04:25:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:34 INFO - 'NO_EM_RESTART': '1', 04:25:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:34 INFO - 'PWD': '/builds/slave/test', 04:25:34 INFO - 'SHELL': '/bin/bash', 04:25:34 INFO - 'SHLVL': '1', 04:25:34 INFO - 'TERM': 'linux', 04:25:34 INFO - 'TMOUT': '86400', 04:25:34 INFO - 'USER': 'cltbld', 04:25:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331', 04:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:34 INFO - '_': '/tools/buildbot/bin/python'} 04:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:35 INFO - Downloading/unpacking psutil>=3.1.1 04:25:35 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 04:25:35 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 04:25:35 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 04:25:35 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 04:25:35 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 04:25:35 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 04:25:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:25:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:37 INFO - Installing collected packages: psutil 04:25:37 INFO - Running setup.py install for psutil 04:25:37 INFO - building 'psutil._psutil_linux' extension 04:25:37 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 04:25:37 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 04:25:37 INFO - building 'psutil._psutil_posix' extension 04:25:37 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 04:25:37 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 04:25:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:37 INFO - Successfully installed psutil 04:25:37 INFO - Cleaning up... 04:25:37 INFO - Return code: 0 04:25:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:25:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f769c20af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d66f60>, '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 0x1d67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d681d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331', '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 04:25:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:25:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:25:37 INFO - Using env: {'DISPLAY': ':0', 04:25:37 INFO - 'HOME': '/home/cltbld', 04:25:37 INFO - 'LANG': 'en_US.UTF-8', 04:25:37 INFO - 'LANGUAGE': 'en_US:en', 04:25:37 INFO - 'LOGNAME': 'cltbld', 04:25:37 INFO - 'MAIL': '/var/mail/cltbld', 04:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:37 INFO - 'MOZ_NO_REMOTE': '1', 04:25:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:37 INFO - 'NO_EM_RESTART': '1', 04:25:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:37 INFO - 'PWD': '/builds/slave/test', 04:25:37 INFO - 'SHELL': '/bin/bash', 04:25:37 INFO - 'SHLVL': '1', 04:25:37 INFO - 'TERM': 'linux', 04:25:37 INFO - 'TMOUT': '86400', 04:25:37 INFO - 'USER': 'cltbld', 04:25:37 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331', 04:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:37 INFO - '_': '/tools/buildbot/bin/python'} 04:25:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:25:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:25:39 INFO - Installing collected packages: mozsystemmonitor 04:25:39 INFO - Running setup.py install for mozsystemmonitor 04:25:39 INFO - Successfully installed mozsystemmonitor 04:25:39 INFO - Cleaning up... 04:25:39 INFO - Return code: 0 04:25:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f769c20af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d66f60>, '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 0x1d67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d681d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331', '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 04:25:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:25:39 INFO - Using env: {'DISPLAY': ':0', 04:25:39 INFO - 'HOME': '/home/cltbld', 04:25:39 INFO - 'LANG': 'en_US.UTF-8', 04:25:39 INFO - 'LANGUAGE': 'en_US:en', 04:25:39 INFO - 'LOGNAME': 'cltbld', 04:25:39 INFO - 'MAIL': '/var/mail/cltbld', 04:25:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:39 INFO - 'MOZ_NO_REMOTE': '1', 04:25:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:39 INFO - 'NO_EM_RESTART': '1', 04:25:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:39 INFO - 'PWD': '/builds/slave/test', 04:25:39 INFO - 'SHELL': '/bin/bash', 04:25:39 INFO - 'SHLVL': '1', 04:25:39 INFO - 'TERM': 'linux', 04:25:39 INFO - 'TMOUT': '86400', 04:25:39 INFO - 'USER': 'cltbld', 04:25:39 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331', 04:25:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:39 INFO - '_': '/tools/buildbot/bin/python'} 04:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:40 INFO - Downloading/unpacking jsonschema==2.5.1 04:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:25:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:42 INFO - Downloading functools32-3.2.3-2.tar.gz 04:25:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:25:42 INFO - warning: no files found matching '*.txt' 04:25:42 INFO - no previously-included directories found matching 'build' 04:25:42 INFO - no previously-included directories found matching 'dist' 04:25:42 INFO - no previously-included directories found matching '.git*' 04:25:42 INFO - Installing collected packages: jsonschema, functools32 04:25:42 INFO - Running setup.py install for functools32 04:25:42 INFO - warning: no files found matching '*.txt' 04:25:42 INFO - no previously-included directories found matching 'build' 04:25:42 INFO - no previously-included directories found matching 'dist' 04:25:42 INFO - no previously-included directories found matching '.git*' 04:25:42 INFO - Successfully installed jsonschema functools32 04:25:42 INFO - Cleaning up... 04:25:42 INFO - Return code: 0 04:25:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f769c20af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d66f60>, '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 0x1d67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d681d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331', '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 04:25:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:25:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:25:42 INFO - Using env: {'DISPLAY': ':0', 04:25:42 INFO - 'HOME': '/home/cltbld', 04:25:42 INFO - 'LANG': 'en_US.UTF-8', 04:25:42 INFO - 'LANGUAGE': 'en_US:en', 04:25:42 INFO - 'LOGNAME': 'cltbld', 04:25:42 INFO - 'MAIL': '/var/mail/cltbld', 04:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:42 INFO - 'MOZ_NO_REMOTE': '1', 04:25:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:42 INFO - 'NO_EM_RESTART': '1', 04:25:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:42 INFO - 'PWD': '/builds/slave/test', 04:25:42 INFO - 'SHELL': '/bin/bash', 04:25:42 INFO - 'SHLVL': '1', 04:25:42 INFO - 'TERM': 'linux', 04:25:42 INFO - 'TMOUT': '86400', 04:25:42 INFO - 'USER': 'cltbld', 04:25:42 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331', 04:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:42 INFO - '_': '/tools/buildbot/bin/python'} 04:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:25:42 INFO - Cleaning up... 04:25:42 INFO - Return code: 0 04:25:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f769c20af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d66f60>, '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 0x1d67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d681d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331', '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 04:25:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:25:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:25:42 INFO - Using env: {'DISPLAY': ':0', 04:25:42 INFO - 'HOME': '/home/cltbld', 04:25:42 INFO - 'LANG': 'en_US.UTF-8', 04:25:42 INFO - 'LANGUAGE': 'en_US:en', 04:25:42 INFO - 'LOGNAME': 'cltbld', 04:25:42 INFO - 'MAIL': '/var/mail/cltbld', 04:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:42 INFO - 'MOZ_NO_REMOTE': '1', 04:25:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:42 INFO - 'NO_EM_RESTART': '1', 04:25:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:42 INFO - 'PWD': '/builds/slave/test', 04:25:42 INFO - 'SHELL': '/bin/bash', 04:25:42 INFO - 'SHLVL': '1', 04:25:42 INFO - 'TERM': 'linux', 04:25:42 INFO - 'TMOUT': '86400', 04:25:42 INFO - 'USER': 'cltbld', 04:25:42 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331', 04:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:42 INFO - '_': '/tools/buildbot/bin/python'} 04:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:43 INFO - Downloading/unpacking blobuploader==1.2.4 04:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:44 INFO - Downloading blobuploader-1.2.4.tar.gz 04:25:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:25:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:25:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:45 INFO - Downloading docopt-0.6.1.tar.gz 04:25:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:25:45 INFO - Installing collected packages: blobuploader, requests, docopt 04:25:45 INFO - Running setup.py install for blobuploader 04:25:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:25:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:25:45 INFO - Running setup.py install for requests 04:25:46 INFO - Running setup.py install for docopt 04:25:46 INFO - Successfully installed blobuploader requests docopt 04:25:46 INFO - Cleaning up... 04:25:46 INFO - Return code: 0 04:25:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25: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')]} 04:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25: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')]} 04:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:46 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 0x7f769c20af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d66f60>, '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 0x1d67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d681d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331', '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 04:25:46 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 04:25:46 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 04:25:46 INFO - Using env: {'DISPLAY': ':0', 04:25:46 INFO - 'HOME': '/home/cltbld', 04:25:46 INFO - 'LANG': 'en_US.UTF-8', 04:25:46 INFO - 'LANGUAGE': 'en_US:en', 04:25:46 INFO - 'LOGNAME': 'cltbld', 04:25:46 INFO - 'MAIL': '/var/mail/cltbld', 04:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:46 INFO - 'MOZ_NO_REMOTE': '1', 04:25:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:46 INFO - 'NO_EM_RESTART': '1', 04:25:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:46 INFO - 'PWD': '/builds/slave/test', 04:25:46 INFO - 'SHELL': '/bin/bash', 04:25:46 INFO - 'SHLVL': '1', 04:25:46 INFO - 'TERM': 'linux', 04:25:46 INFO - 'TMOUT': '86400', 04:25:46 INFO - 'USER': 'cltbld', 04:25:46 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331', 04:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:46 INFO - '_': '/tools/buildbot/bin/python'} 04:25:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:46 INFO - Running setup.py (path:/tmp/pip-Q_4b59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:46 INFO - Running setup.py (path:/tmp/pip-bD05An-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:46 INFO - Running setup.py (path:/tmp/pip-igXMT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:46 INFO - Running setup.py (path:/tmp/pip-zz5Mhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:46 INFO - Running setup.py (path:/tmp/pip-KYlwlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:46 INFO - Running setup.py (path:/tmp/pip-K50VKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:46 INFO - Running setup.py (path:/tmp/pip-PDxap4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:47 INFO - Running setup.py (path:/tmp/pip-O7Bs9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:47 INFO - Running setup.py (path:/tmp/pip-JAk1oc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:47 INFO - Running setup.py (path:/tmp/pip-fux52h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:47 INFO - Running setup.py (path:/tmp/pip-Evuk2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:47 INFO - Running setup.py (path:/tmp/pip-eWPyX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:47 INFO - Running setup.py (path:/tmp/pip-8rK4NS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:47 INFO - Running setup.py (path:/tmp/pip-oZ66aY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:47 INFO - Running setup.py (path:/tmp/pip-B8ffcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:47 INFO - Running setup.py (path:/tmp/pip-fC2xuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:47 INFO - Running setup.py (path:/tmp/pip-Ub8nJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:25:47 INFO - Running setup.py install for manifestparser 04:25:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:25:47 INFO - Running setup.py install for mozcrash 04:25:47 INFO - Running setup.py install for mozdebug 04:25:48 INFO - Running setup.py install for mozdevice 04:25:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:25:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:25:48 INFO - Running setup.py install for mozfile 04:25:48 INFO - Running setup.py install for mozhttpd 04:25:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:25:48 INFO - Running setup.py install for mozinfo 04:25:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:25:48 INFO - Running setup.py install for mozInstall 04:25:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:25:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:25:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:25:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:25:48 INFO - Running setup.py install for mozleak 04:25:48 INFO - Running setup.py install for mozlog 04:25:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:25:48 INFO - Running setup.py install for moznetwork 04:25:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:25:48 INFO - Running setup.py install for mozprocess 04:25:49 INFO - Running setup.py install for mozprofile 04:25:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:25:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:25:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:25:49 INFO - Running setup.py install for mozrunner 04:25:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:25:49 INFO - Running setup.py install for mozscreenshot 04:25:49 INFO - Running setup.py install for moztest 04:25:49 INFO - Running setup.py install for mozversion 04:25:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:25:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:25:49 INFO - Cleaning up... 04:25:49 INFO - Return code: 0 04:25:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:49 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 0x7f769c20af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d66f60>, '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 0x1d67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d681d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331', '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 04:25:49 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 04:25:49 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 04:25:49 INFO - Using env: {'DISPLAY': ':0', 04:25:49 INFO - 'HOME': '/home/cltbld', 04:25:49 INFO - 'LANG': 'en_US.UTF-8', 04:25:49 INFO - 'LANGUAGE': 'en_US:en', 04:25:49 INFO - 'LOGNAME': 'cltbld', 04:25:49 INFO - 'MAIL': '/var/mail/cltbld', 04:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:49 INFO - 'MOZ_NO_REMOTE': '1', 04:25:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:49 INFO - 'NO_EM_RESTART': '1', 04:25:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:49 INFO - 'PWD': '/builds/slave/test', 04:25:49 INFO - 'SHELL': '/bin/bash', 04:25:49 INFO - 'SHLVL': '1', 04:25:49 INFO - 'TERM': 'linux', 04:25:49 INFO - 'TMOUT': '86400', 04:25:49 INFO - 'USER': 'cltbld', 04:25:49 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331', 04:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:49 INFO - '_': '/tools/buildbot/bin/python'} 04:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:49 INFO - Running setup.py (path:/tmp/pip-GsFC7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:49 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)) 04:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:49 INFO - Running setup.py (path:/tmp/pip-Xj01R3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:49 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)) 04:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:49 INFO - Running setup.py (path:/tmp/pip-vxjQCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:50 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)) 04:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:50 INFO - Running setup.py (path:/tmp/pip-tvAgAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:50 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)) 04:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:50 INFO - Running setup.py (path:/tmp/pip-vY9x4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:50 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)) 04:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:50 INFO - Running setup.py (path:/tmp/pip-_s5ftj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:50 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)) 04:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:50 INFO - Running setup.py (path:/tmp/pip-DRmgFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:50 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)) 04:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:50 INFO - Running setup.py (path:/tmp/pip-WkaIoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:50 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)) 04:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:50 INFO - Running setup.py (path:/tmp/pip-2EkBdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:50 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)) 04:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:50 INFO - Running setup.py (path:/tmp/pip-7LKzFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:50 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)) 04:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:50 INFO - Running setup.py (path:/tmp/pip-XUspD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:50 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)) 04:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:50 INFO - Running setup.py (path:/tmp/pip-fPBeTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:50 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)) 04:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:50 INFO - Running setup.py (path:/tmp/pip-gClYLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:50 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)) 04:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:50 INFO - Running setup.py (path:/tmp/pip-QYAE47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:50 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)) 04:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:50 INFO - Running setup.py (path:/tmp/pip-Q6LCj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:50 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)) 04:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:50 INFO - Running setup.py (path:/tmp/pip-gjFHp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:51 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)) 04:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:51 INFO - Running setup.py (path:/tmp/pip-_DFqj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:51 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)) 04:25:51 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)) 04:25:51 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)) 04:25:51 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)) 04:25:51 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)) 04:25:51 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)) 04:25:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:53 INFO - Downloading blessings-1.6.tar.gz 04:25:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:25:53 INFO - Installing collected packages: blessings 04:25:53 INFO - Running setup.py install for blessings 04:25:53 INFO - Successfully installed blessings 04:25:53 INFO - Cleaning up... 04:25:53 INFO - Return code: 0 04:25:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:25:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:25:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:25:53 INFO - Reading from file tmpfile_stdout 04:25:53 INFO - Current package versions: 04:25:53 INFO - argparse == 1.2.1 04:25:53 INFO - blessings == 1.6 04:25:53 INFO - blobuploader == 1.2.4 04:25:53 INFO - docopt == 0.6.1 04:25:53 INFO - functools32 == 3.2.3-2 04:25:53 INFO - jsonschema == 2.5.1 04:25:53 INFO - manifestparser == 1.1 04:25:53 INFO - mozInstall == 1.12 04:25:53 INFO - mozcrash == 0.17 04:25:53 INFO - mozdebug == 0.1 04:25:53 INFO - mozdevice == 0.48 04:25:53 INFO - mozfile == 1.2 04:25:53 INFO - mozhttpd == 0.7 04:25:53 INFO - mozinfo == 0.9 04:25:53 INFO - mozleak == 0.1 04:25:53 INFO - mozlog == 3.4 04:25:53 INFO - moznetwork == 0.27 04:25:53 INFO - mozprocess == 0.23 04:25:53 INFO - mozprofile == 0.28 04:25:53 INFO - mozrunner == 6.12 04:25:53 INFO - mozscreenshot == 0.1 04:25:53 INFO - mozsystemmonitor == 0.3 04:25:53 INFO - moztest == 0.7 04:25:53 INFO - mozversion == 1.4 04:25:53 INFO - psutil == 3.1.1 04:25:53 INFO - requests == 1.2.3 04:25:53 INFO - wsgiref == 0.1.2 04:25:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:53 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')]} 04:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:53 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')]} 04:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:53 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 0x7f769c20af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d66f60>, '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 0x1d67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d681d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331', '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 04:25:53 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 04:25:53 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 04:25:53 INFO - Using env: {'DISPLAY': ':0', 04:25:53 INFO - 'HOME': '/home/cltbld', 04:25:53 INFO - 'LANG': 'en_US.UTF-8', 04:25:53 INFO - 'LANGUAGE': 'en_US:en', 04:25:53 INFO - 'LOGNAME': 'cltbld', 04:25:53 INFO - 'MAIL': '/var/mail/cltbld', 04:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:53 INFO - 'MOZ_NO_REMOTE': '1', 04:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:53 INFO - 'NO_EM_RESTART': '1', 04:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:53 INFO - 'PWD': '/builds/slave/test', 04:25:53 INFO - 'SHELL': '/bin/bash', 04:25:53 INFO - 'SHLVL': '1', 04:25:53 INFO - 'TERM': 'linux', 04:25:53 INFO - 'TMOUT': '86400', 04:25:53 INFO - 'USER': 'cltbld', 04:25:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331', 04:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:53 INFO - '_': '/tools/buildbot/bin/python'} 04:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:53 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)) 04:25:53 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)) 04:25:53 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)) 04:25:53 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)) 04:25:53 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)) 04:25:53 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)) 04:25:53 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)) 04:25:53 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)) 04:25:53 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)) 04:25:53 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)) 04:25:53 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)) 04:25:53 INFO - Cleaning up... 04:25:53 INFO - Return code: 0 04:25:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:25:53 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')]} 04:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:53 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')]} 04:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:53 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 0x7f769c20af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d66f60>, '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 0x1d67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d681d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331', '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 04:25:53 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 04:25:53 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 04:25:53 INFO - Using env: {'DISPLAY': ':0', 04:25:53 INFO - 'HOME': '/home/cltbld', 04:25:53 INFO - 'LANG': 'en_US.UTF-8', 04:25:53 INFO - 'LANGUAGE': 'en_US:en', 04:25:53 INFO - 'LOGNAME': 'cltbld', 04:25:53 INFO - 'MAIL': '/var/mail/cltbld', 04:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:53 INFO - 'MOZ_NO_REMOTE': '1', 04:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:53 INFO - 'NO_EM_RESTART': '1', 04:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:53 INFO - 'PWD': '/builds/slave/test', 04:25:53 INFO - 'SHELL': '/bin/bash', 04:25:53 INFO - 'SHLVL': '1', 04:25:53 INFO - 'TERM': 'linux', 04:25:53 INFO - 'TMOUT': '86400', 04:25:53 INFO - 'USER': 'cltbld', 04:25:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331', 04:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:53 INFO - '_': '/tools/buildbot/bin/python'} 04:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:25:53 INFO - Cleaning up... 04:25:53 INFO - Return code: 0 04:25:53 INFO - Running post-action listener: _resource_record_post_action 04:25:53 INFO - Running post-action listener: _start_resource_monitoring 04:25:54 INFO - Starting resource monitoring. 04:25:54 INFO - [mozharness: 2016-10-12 11:25:54.009009Z] Finished create-virtualenv step (success) 04:25:54 INFO - [mozharness: 2016-10-12 11:25:54.009512Z] Running install step. 04:25:54 INFO - Running pre-action listener: _resource_record_pre_action 04:25:54 INFO - Running main action method: install 04:25:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:25:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:25:54 INFO - Reading from file tmpfile_stdout 04:25:54 INFO - Detecting whether we're running mozinstall >=1.0... 04:25:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:25:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:25:54 INFO - Reading from file tmpfile_stdout 04:25:54 INFO - Output received: 04:25:54 INFO - Usage: mozinstall [options] installer 04:25:54 INFO - Options: 04:25:54 INFO - -h, --help show this help message and exit 04:25:54 INFO - -d DEST, --destination=DEST 04:25:54 INFO - Directory to install application into. [default: 04:25:54 INFO - "/builds/slave/test"] 04:25:54 INFO - --app=APP Application being installed. [default: firefox] 04:25:54 INFO - mkdir: /builds/slave/test/build/application 04:25:54 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'] 04:25:54 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 04:26:10 INFO - Reading from file tmpfile_stdout 04:26:10 INFO - Output received: 04:26:10 INFO - /builds/slave/test/build/application/firefox/firefox 04:26:10 INFO - Running post-action listener: _resource_record_post_action 04:26:10 INFO - [mozharness: 2016-10-12 11:26:10.485151Z] Finished install step (success) 04:26:10 INFO - [mozharness: 2016-10-12 11:26:10.485393Z] Running run-tests step. 04:26:10 INFO - Running pre-action listener: _resource_record_pre_action 04:26:10 INFO - Running main action method: run_tests 04:26:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:26:10 INFO - Python 2.7.3 04:26:10 INFO - Return code: 0 04:26:10 INFO - grabbing minidump binary from tooltool 04:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:10 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 0x1d66f60>, '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 0x1d67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d681d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:26:10 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 04:26:10 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 04:26:10 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 04:26:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:26:10 INFO - Return code: 0 04:26:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:26:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:26:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:26:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:26:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:26:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d8F0IIknSh2rAc6bVY6TPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 04:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d8F0IIknSh2rAc6bVY6TPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 04:26:10 INFO - Using env: {'DISPLAY': ':0', 04:26:10 INFO - 'HOME': '/home/cltbld', 04:26:10 INFO - 'LANG': 'en_US.UTF-8', 04:26:10 INFO - 'LANGUAGE': 'en_US:en', 04:26:10 INFO - 'LOGNAME': 'cltbld', 04:26:10 INFO - 'MAIL': '/var/mail/cltbld', 04:26:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:26:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:10 INFO - 'MOZ_NO_REMOTE': '1', 04:26:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:26:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:10 INFO - 'NO_EM_RESTART': '1', 04:26:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:10 INFO - 'PWD': '/builds/slave/test', 04:26:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:26:10 INFO - 'SHELL': '/bin/bash', 04:26:10 INFO - 'SHLVL': '1', 04:26:10 INFO - 'TERM': 'linux', 04:26:10 INFO - 'TMOUT': '86400', 04:26:10 INFO - 'USER': 'cltbld', 04:26:10 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331', 04:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:10 INFO - '_': '/tools/buildbot/bin/python'} 04:26:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d8F0IIknSh2rAc6bVY6TPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 04:26:10 INFO - mozversion application_buildid: 20161012030247 04:26:10 INFO - mozversion application_changeset: aa8629a25ab5aeb2678a0187e50336659d368b44 04:26:10 INFO - mozversion application_display_name: Nightly 04:26:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:26:10 INFO - mozversion application_name: Firefox 04:26:10 INFO - mozversion application_remotingname: firefox 04:26:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:26:10 INFO - mozversion application_vendor: Mozilla 04:26:10 INFO - mozversion application_version: 52.0a1 04:26:10 INFO - mozversion platform_buildid: 20161012030247 04:26:10 INFO - mozversion platform_changeset: aa8629a25ab5aeb2678a0187e50336659d368b44 04:26:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:26:10 INFO - mozversion platform_version: 52.0a1 04:26:10 INFO - using testdate: 1476271570 04:26:10 INFO - actual date: 1476271570 04:26:10 INFO - starting webserver on 'localhost:55835' 04:26:10 INFO - SUITE-START | Running 2 tests 04:26:10 INFO - TEST-START | dromaeo_css 04:26:10 INFO - operating with platform_type : linux_ 04:26:10 INFO - Initialising browser for dromaeo_css test... 04:26:10 INFO - TEST-INFO | started process 5814 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppIlbFe/profile http://localhost:55835/getInfo.html) 04:26:14 INFO - PROCESS | 5814 | __metrics Screen width/height:1600/1200 04:26:14 INFO - PROCESS | 5814 | colorDepth:24 04:26:14 INFO - PROCESS | 5814 | Browser inner width/height: 1024/697 04:26:14 INFO - PROCESS | 5814 | __metrics 04:26:15 INFO - PROCESS | 5814 | 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" 04:26:15 INFO - PROCESS | 5814 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:26:15 INFO - PROCESS | 5814 | console.error: PushService: 04:26:15 INFO - PROCESS | 5814 | stateChangeProcessEnqueue: Error transitioning state 04:26:15 INFO - PROCESS | 5814 | UnknownError 04:26:16 INFO - TEST-INFO | 5814: exit 0 04:26:16 INFO - Browser initialized. 04:26:16 INFO - Running cycle 1/1 for dromaeo_css test... 04:26:16 INFO - TEST-INFO | started process 5895 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppIlbFe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:28 INFO - PROCESS | 5895 | RSS: Main: 174022656 04:26:28 INFO - PROCESS | 5895 | 04:27:19 INFO - PROCESS | 5895 | 1476271639465 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] 04:29:33 INFO - PROCESS | 5895 | Cycle 1(1): loaded http://localhost:55835/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55835/tests/dromaeo/cssquery-ext.html) 04:29:35 INFO - PROCESS | 5895 | RSS: Main: 375431168 04:29:35 INFO - PROCESS | 5895 | 04:32:38 INFO - PROCESS | 5895 | Cycle 1(1): loaded http://localhost:55835/tests/dromaeo/cssquery-ext.html (next: http://localhost:55835/tests/dromaeo/cssquery-jquery.html) 04:32:38 INFO - PROCESS | 5895 | RSS: Main: 280363008 04:32:38 INFO - PROCESS | 5895 | 04:35:41 INFO - PROCESS | 5895 | Cycle 1(1): loaded http://localhost:55835/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55835/tests/dromaeo/cssquery-mootools.html) 04:35:41 INFO - PROCESS | 5895 | RSS: Main: 246673408 04:35:41 INFO - PROCESS | 5895 | 04:38:43 INFO - PROCESS | 5895 | Cycle 1(1): loaded http://localhost:55835/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55835/tests/dromaeo/cssquery-prototype.html) 04:38:44 INFO - PROCESS | 5895 | RSS: Main: 220049408 04:38:44 INFO - PROCESS | 5895 | 04:41:47 INFO - PROCESS | 5895 | Cycle 1(1): loaded http://localhost:55835/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55835/tests/dromaeo/cssquery-yui.html) 04:41:48 INFO - PROCESS | 5895 | RSS: Main: 220229632 04:41:48 INFO - PROCESS | 5895 | 04:44:51 INFO - PROCESS | 5895 | Cycle 1(1): loaded http://localhost:55835/tests/dromaeo/cssquery-yui.html (next: http://localhost:55835/tests/dromaeo/cssquery-dojo.html) 04:44:51 INFO - PROCESS | 5895 | RSS: Main: 312496128 04:44:51 INFO - PROCESS | 5895 | 04:44:51 INFO - PROCESS | 5895 | __start_tp_report 04:44:51 INFO - PROCESS | 5895 | _x_x_mozilla_page_load 04:44:51 INFO - PROCESS | 5895 | _x_x_mozilla_page_load_details 04:44:51 INFO - PROCESS | 5895 | |i|pagename|runs| 04:44:51 INFO - PROCESS | 5895 | |0;dojo.html;2568.6275490053945;2599.7010343810466;2623.4884197581473;2637.393399518111;2649.8012649051316;4661.997670500841;4730;4745.098431298055;4755.833545825897;4773.474917759044;4759.714417134975;4776.71339719617;4821.662483626147;4860.562549370556;4888.975555122228;4351.173277077345;4368.737875727451;4401.317795741666;4437.156940181371;4438.467383913935;4452.910941781162;4517.2094883395275;4522.751248681321;4523.411956445674;4546.0680560485025;4278.700490965633;4412.316091005867;4430.933535996963;4467.7319360838455;4551.931721024187;4318.935215971763;4365.869023929287;4371.322445021026;4380.693351465398;4387.868363949086;4354.107407981356;4360.7819609019425;4360.978195109036;4413.227685155117;4427.955720442818;4723.126221648971;4748.477667456577;4777.307290442901;4792.161371759928;4844.37023186987;4886.169351210303;4934.876628084291;4938;5096.949030509684;5122.641415100945;5151.17581187012;5167.612429067835;5170;5224.843254702327;5235.188545775411;4784.880377990543;4785.904281914342;4786.305985632064;4788.497207793132;4851.587615052689;5087.669301495391;5168.3539557555305;5263.657862239019;5264.894702105937;5268;5001.44984051754;5015.4733752956145;5049.949500505021;5055.494450554988;5122.385313762298;5123.897522049613;5134.87162820925;5135.512126348066;5140.640155189101;5141.38303403594;5034.194528875436;5049.394072711299;5083.8983220335385;5133.512316329943;5150.381954165449;4883.95116048835;4929;4938.358013458227;4998.775055122528;5006.3992320921;4174.749515029108;4174.91650166995;4174.979125104416;4176.31090870003;4178.101708132766;3648.1062139775927;3660.908477288089;3713.6843368313457;3724.7020238380865;3728.7949162795762;4382.05785756064;4383.364412160219;4413.029133590605;4440.3561483585345;4444.422225110715;5065.924011139836;5112.233165025276;5114.462981386975;5135.871603209875;5157.4584668610005;4256.787160641956;4311.935320970188;4379.715318504287;4381.715188512737;4441.133978874153;4472.44094488189;4510;4511.932321015187;4520.299353600197;4597.034622729264;4755.025219829927;4760.952390476189;4762.666613337172;4766.571008609242;4826.686265392738;5071.264666623245;5080.568151706999;5080.872978175576;5083.135866902561;5139.743012849417;4632.4672662644225;4681.250999840009;4704.482506924167;4749.26386410107;4753.453352864465;4929.507049295042;4956.231784073474;4960.70235785854;4962.503749625009;4967.3542439482635;5029.74851257443;5117.43708192106;5159.251908473326;5176.741162941763;5245.291885595549;5036.118679231193;5038.294638750504;5041.8487445376695;5093.439721630692;5105.7191854448365;4995.125852975787;5023.321851549994;5037.143685573388;5042.445331013659;5098.056859481007;4629.259318509023;4664.113818374498;4706.529347065266;4949.33184020167;4953.9752301239705;4894.877628059327;4895.559399654048;4896.1921282987905;4898.093852637274;4901.362822833009;4796.832110876242;4819.518048195152;4846.273059041172;4877.756112194447;4909.018196360671 04:44:51 INFO - PROCESS | 5895 | |1;ext.html;554.0636324611406;567.5884983387045;575.772569834915;580.8170426315708;583.7956715149696;36865.63134368655;38416.3108582399;38578.42132368013;38627.22745545088;42174.15651686972;38872.22255554894;39274.607253927454;39331.21337573247;39333.409998849966;39358.85129189658;7438.181800002009;7577.204393538682;7580.090389153309;7580.810479737996;7583.203763604824;7307.598082105482;7389;7390.556566605994;7391.223921488247;7391.926080739177;7388.667509962038;7414.184439711627;7425.405967522613;7430.442716796235;7432.739854105107;7321.304476074764;7330;7339.559626422379;7342.816429589277;7349.118105827281;7505.887411688829;7575.886361704579;7577.204393538709;7579.62101894903;7587.582682952436;35845.10387240314;36108.277834443164;36118;36146;36160;3011;3025.803322784012;3037.2862377341307;3304.7686661933676;3578.6779189873037;27524.174274771787;27900;28464.28839279014;29743.405131897456;29774.255643608867;3184.538241954927;3224.0489055728617;3226.887058952949;3233.369492948876;3275.3776782411264;175739;175778;175848.99999999872;175928;176708;31140.68859311423;32052;32126.518102228485;51951;52255;33541.49687754686;33765.49351759726;33792.1551961198;33860;33860.830695846365;12112.939435302944;12323.75352492963;12343.814842777365;12481.93759031199;12486.313252771184;9549.045095490395;9554.808903821884;9555;9577.712668619952;9605.423674579548;7792.493487923267;7806.960965195138;7848.293653571091;7944.642491087915;7948.324392426708;3064.7088526589937;3071.6006919100373;3094.9535756963664;3110.1602567307154;3110.751139908802;863.6027427383474;873.6636394987976;912.6623149434752;915.8076803871129;993.0665174735725;27130;27493.725062749116;27940.58089128665;28172.71827281742;28453.85773071163;909.836229478687;970.5050424283667;975.6341371985505;996.138340335619;1017.6743442098606;14215.64460888486;14603;14940.551783446514;14945.775813362809;15123.773143402857;376520;380607;380615;381155;381201;48051.5194848054;48569.514304857206;48702.512974869795;48713;48743.268850967266;1108.1245815805585;1136.471540733563;1145.9541618335172;1152.2395219155317;1160.7562411893598;25289.367765806;26223.60664590071;26912.77849935074;27196.456070878867;27275.31811704723;41142.177156456106;41602.58397415987;41658.375124373764;41782;41789.79105104455;296819;298610;299174;299840;301450;25272.873635631706;25743.871280644227;25952.610710838973;25984;25995.350116247246;40161;40595.36432372421;40903.7954810236;41552.58447415608;42133.367999480644;34682;34779.82610086934;34971.12572185614;35256.64743352534;35557.64442355543;34846.65153348434;34921.650783492856;35347;35782;35838.10404739902;34694.30611387808;34703.47944780881;34749.13127171841;35764;37918;30579;33038.50442243416;33048.66951330456;33141.66858331482;33246;24597.754022460264;25571.872140639178;25584;25983.480330392907;26044.34889127787 04:44:51 INFO - PROCESS | 5895 | |2;jquery.html;340.4008944258105;358.4211498430035;367.8767612849695;373.85232833030943;384.58464857953413;12194.451249693762;13103.213807171565;13223.603291901234;16639;16666.66666666666;14927.92536037321;14964.850351496481;15948.122853243067;15957.441489547868;15987;4891.388576427947;5066.645334826564;5116.488351164891;5119.718415487147;5123.205903085028;3619.7104231661538;3834.5015148030716;5654.802081927133;5933.762649494015;6016.4885984691355;5888.852778680524;6153.661548614825;6157.568970172089;6169.598976066542;6171.13604095427;6008.48927841134;6009.9399006010035;6042.093685947099;6042.244719410074;6045.6070355426755;5224.895502089975;5232.136697444917;5306.973465132688;5319.734013299359;5334.253204551327;20173.092210850547;20189;20313.390598282076;20381.082851271727;20529;1875.409246087478;1880.5674694820132;2332.941676458085;2417.1781594258036;2424.7454017328105;12773.808392874114;12857.871421285761;13047.478100875953;13359.666008349772;13619.931900340434;1699.8555122814575;1723.388197189992;1734.332282071399;1741.3556983915905;1746.5197070805502;66859.66570167166;67916.6604166981;68011.319886801;68394;68495;9081.727548173565;9385.577649005674;9534.856977145348;9560.28297877662;9655.9034409655;12989.740205195843;12990.675233119247;12996.660601091706;13011.739765204642;13020.544280950122;6955.33924277203;7025.789226323219;7032.26161253061;7141.857162856713;7489.667098141274;6829.521933464709;6881.449484041264;6889.965550172217;7293.16128645202;7390.519616225036;5737.540996720252;5801.158831969341;5899.705014749331;5930.169776231331;6118.265808103056;1545.2273863068465;1641.3762770147507;1700.3846345971376;1732.289761197928;1762.171779263744;695.7356204642203;865.1910463716446;870.6430363550913;889.564113584339;899.9595018224196;15430.228488575527;16688.082155481567;17285.827141728674;17678.994570922972;17848.821511784718;839.5634270179472;846.3736834742369;851.7104184577273;868.1405408645521;898.7034278688018;9318.207952323994;10083.092521673085;10102.343347682377;10118.797624047626;10271.229657775548;392748;392887;395662;398145;398173;66880;67146.66426667836;67332.663336683;67984.6600766993;68791;916.6608354908726;917.559571405729;933.0529512544772;951.3863558005048;951.7668171298076;14275.42898284057;14499.49251776225;15678.9216053919;15871.127088010271;16935.66128677395;38480.23039539137;39023.80488097541;39097.60902391053;40051;40377.79811101043;46047.30929036134;48005.51994480011;48360.27459588179;48677.75661121814;49098.26352604642;7378.372838308589;7455.962720186364;7657.923420765944;7733.845323093619;8132.064812546633;8201.548914809742;10845.783084338427;10933.507992140214;11661.708457288636;12177.208481448677;8893.28853691716;9285.582148803454;9587.952060239653;9790.314677972758;10347.689569312932;9194.724158275263;9214.493202873906;9298.95350523243;9401.905980940102;9635.710928672152;9347.626094956126;9427.905720942703;9623.212608287191;9896.851547226941;9942.652007179713;6456.451201647913;6644.402003819486;6680.298568650416;6942.652867356511;7563.659635316534;8039.557824319719;9768.511574421393;10172.50542649511;10363.689089327332;10591.417472039111 04:44:51 INFO - PROCESS | 5895 | |3;mootools.html;1352.9323533823313;1374.7456720506705;1437.195170704405;1598.7921570195872;1636.199672162185;6912.861742765142;7132.286771322865;7401.592912389817;8072.71745488908;8094.433389662726;7437.962810185942;7652.1582625911105;7669;7907.723229686962;7910.248526389983;2172.663237198237;2203.5152266501345;2204.7684993075654;2205.52581195043;2208.9558208835815;1815.5824160443105;1875.990620046898;2139.1764170794277;2168.9566208675815;2188.9671654925187;2094.099537199004;2167.9349619511363;2168.577127460146;2178.1505212966954;2183.3995651195887;2151.440625437382;2171.0989939175224;2176.1948079210792;2177.7604463509;2180.3132013415884;2149.9785002150093;2152.4080877758583;2157.9352619421284;2158.082814803718;2160.0495781855934;7864.370850331959;7941.364690824778;7946.125926148119;7951.085625153066;7993.08079570851;4448.043670610802;4484.506704262529;4519.4802597701355;4523.683342166049;4531.093781243764;2721.360480287131;2908.2293192304055;2972.821630702165;2979.9851000744857;2980.210244285266;930.16285343191;930.1767935377239;936.4194199596226;943.528235882059;948.9762755931088;10731.946340268249;10738.248322617419;10739.78520429595;10740.355578665305;10743.355398676027;4144.91710165795;4151.12826306473;4312.159128969884;4332.783360831946;4369.694121411534;9153.35926485153;9160.083991600786;9165.175134237817;9165.954170229106;9166.633334666672;4686.625069994392;4696.600788932979;4699.107169637758;4699.553542413465;4699.694519856198;4125.886010777073;4216.51510076339;4269.679774016961;4273.803335066186;4277.7647229402055;3588.372034893883;3595.173110184672;3713.442983552489;3714.201446688975;3724.329620668306;1094.9835752463719;1132.7338075552238;1168.3584563688032;1185.3776767197292;1198.7003249187703;770.4529783853415;770.5915864591775;830.5058490198322;830.8462934357163;868.5874209750318;5347.839564813062;5365.356157261075;5387.730613469311;5464.781408743605;5524.696141712245;840.932725381968;860.580941594245;870.4298684361753;882.3177540277485;884.7566919097171;3607.2965771674794;3654.8720794772057;3658.414653655402;3765.2657731742597;3895.2209558088493;9134.862977055349;9431.905680943102;9756;9781.364211326241;9792.657256995972;9543.093406126407;9615;9625.32622716417;9634.13292803651;9635.277354198462;7230.74692385764;7260.92739072613;7294.343509084102;7346.77959661211;7350.007748953823;5051.166557517969;5109.8722531937;5222.7910883565755;5257.185136303879;5434;8646.308295336485;8748.343874209333;8791.824163516565;8798.824023519623;8851.734447966572;8822.735317940473;8953.522668759582;8964.372493925623;9029.23251523628;9040.41237319572;6785.864282714417;6870;6872.62200578973;6873.828154296182;6875.312468753084;7202.3877970373105;7405.074365704287;7465.552066876005;7481.812954676177;7488.700451981859;5618.747156377891;6703.597784132968;6708.463322934056;6734.595924244365;6875.690593923186;6538.378854008862;6618.63597502142;6626.900596491153;6631.966840165961;6632.50256230775;6377.585456945284;6441.098246245623;6443.806685799434;6456.644884531396;6493.058506516623;4474.082813023388;4474.932876006797;4543.750093744744;4596.4254468191475;4645.907081858411;4531;4636.072785442992;4696.530346965276;4716.3868697069165;4766.642501812308 04:44:51 INFO - PROCESS | 5895 | |4;prototype.html;300.7864416264452;306.7760534809589;310.5124953822499;310.85389866762625;314.59103165884346;4783.545563171502;4791.808327666898;4813.783379747915;4818.638602104847;4823.180059389903;4731.33761273422;4743.76281185941;4759.309900064489;4760.404949381327;4760.762201827524;3511.2275299434145;3634.4735211211223;3646.562412510489;3728.571214310362;3772.302124107035;3760.6427389397963;3763.9059023524496;3768.3970564709653;3775.924481510368;3785.9432108518395;3727.7949712765785;3734.253149370123;3734.9253014939686;3735.7384983051197;3751.268502641986;3549.538559987198;3602.7117830573493;3670.9816450917706;3740.8129593520216;3766.2090960898245;3323.6344002159744;3328.3176948725454;3330.5170750241323;3333.4333163362285;3339.6159441664277;4649.651276154302;4654.86035418938;4659.510751371091;4666.719996800169;4669.859904202879;4164.8125834337225;4265.466816647919;4272.889048847322;4291.270484017693;4295.441592592974;4963.503649635044;4972.154733695281;4974.303597496353;4976.402831660188;4984.90030199394;3639.70882329413;3643.2167084076787;3646.690031347339;3648.616895226016;3649.7810131392202;4899.216125419915;5179;5207.739613019372;5214.9217761733225;5215.687058776448;3529.0061115469675;3548.8288864674596;3551.5205447264807;3567.340042092221;3570.3573356795505;3586.085548185248;3591.40741777609;3598.884345852794;3625.329314076904;3633.709303255733;4144.564820693844;4149.356849688304;4150.958490415118;4159.91680166395;4180.916381672349;4775.594074503706;4942.135126352874;4976.825811096594;4977.925331120036;4980.402351717817;1260.3068312428127;1270.707737220426;1273.9490420383265;1274.222724138275;1274.6176147155816;787.7872974296907;809.3484744780391;813.9511629302261;822.3791037766448;825.9628316725762;4026.617471340218;4287.121140166259;4391.165678521071;4415.867523974286;4529;5130.384353877558;5189.76646050921;5196.8960620787375;5197.168453047494;5199.402068762065;4438.889027774267;4520.773961301922;4529.139463501924;4531.207038768268;4532.27483602622;2604.9869750651123;2699.743524365182;2709.227870057024;2714.4164004739077;2735.603337516049;4812.013537224861;4848.878778030577;4848.927266091011;4854.902901941941;4859.392575928009;5244.973775131176;5245.737713114329;5250.159974404077;5272.841814745564;5273.393559740679;4721.787519561628;4792.076833131787;4792.305115758196;4835.99999999993;4839.758012099452;5128.410232823124;5143.871403214949;5146.485351464824;5148.124818780741;5150.536451719363;5053.115704751727;5057.799857062189;5058.595312375075;5071.594272458268;5071.721055341992;4561.749103799323;4833.993892534559;4899.730514821719;4909;4921.3356196912955;3653.2693461307313;3662.633736626316;3667.889963301105;3668.871589494355;3673.669369756735;5217.165253559564;5217.217417387422;5219.217117432264;5221.433569929082;5230.241614965885;4900.409276944066;4949.430815456125;4998.4501704813165;5045.6720313180995;5048.924266136084;5015.297858299914;5034.4462109167225;5047.4952504749235;5053.469385714447;5065.898682026265;4969.304297398295;4973.030259099441;4979.900401992012;5004.449510553909;5021.171506701354;4785.306130610972;4891.902161956812;4895.8041678332465;5034.572061374824;5083.517065878736;4715.204260570274;4893.363862697826;4910.435299940553;4915.21356582945;4925.0396172747405 04:44:51 INFO - PROCESS | 5895 | |5;yui.html;608.1637748096367;614.4377993399012;619.2043224456572;625.2028663454093;643.4241353988177;12077.456514456848;12265.816012759815;13017.349132543382;13185.868141318584;13189.010824188188;12869.871301286985;12898.677533061678;13009.869901300985;13052.086353955227;13088.541901033466;599.3048064245476;752.6801109528456;770.4067867741863;773.1611201846003;774.0131332551015;615.5045188623156;748.8988986486836;767.9731209407672;773.5668025905483;775.4300589067032;808.0505406147782;809.5587904592012;809.8015986083418;811.4887620798888;812.2851890336525;621.189347900989;803.4175222963335;803.586153131138;804.111456840189;804.2480280937342;468.1736734663322;561.6826493031424;576.5474102829259;578.7627072900133;578.8552861784553;12946.546870859569;13002.739945201138;13045.282509461977;13049.934750326187;13078.280694561796;11921.344326062062;12189;12364.134510584263;12545.811812822723;12974.481020759253;11320.490577924013;11489.655310340702;11680.299182049104;11779.528818847322;11927.105467090003;3919.4904662393706;3945.6646185074305;3988.4615576897327;4065.26825171469;4109.547949725527;60625.69687151536;61707.691461542854;63175;64317.35682643207;64509.67745161244;9632;9774.609015639295;9814.754631134136;9886.258530610234;9904.158146557624;18309.3591724289;18341.7248741269;18490.907545462454;18598.81401185998;18734.81265187358;6282.4974002079725;6293.1504246927;6373;6392.840178995562;6420.807375778734;3477.0959550517045;3489.092835862694;3567.554055743032;3597.604263531062;3614.150674591469;2989.342344684166;3096.9380612387627;3115.439220940207;3117.2986078132694;3119.1890108571934;523.677938068093;525.0863497514374;526.2317017154996;532.6351449257271;535.3816342124852;470.6587723900145;471.5590922487485;493.6692416081234;522.0212102308172;568.8321945026228;7785.221477852283;7810.648520816577;7906;7974.481658692166;8111.837763244702;539.6600141910571;570.492261886921;576.533008263308;583.1107560969471;589.8643312038255;3567.696745776638;3747.793871337048;3882.786446745456;4149.315362965077;4191.455110835633;95437;98399;99680.50159749154;100003.49998250107;100636.43397309624;50799;73771;79167;82313.58843205865;83253;49072.754636227306;73327.63336183285;77319;78412.21587784277;80786.19213807904;7674.769756907302;7717.421193410404;7765.689372425039;7842.176571460142;7967.601619919097;32104.197395065312;37027;43591.12817743564;44182.33726494169;44227;39748.40377394284;62909;63287.6835615819;64541;67010;10530.31552949056;10854.861297339312;11058.11535077208;11243.718907027389;11376.94311528437;11580.768384632429;11625.47685354178;11915;12436.564720234748;12739.108262421913;11356.205065645325;11873.881261187278;11949.163558551165;12076.033917286772;12267.877321226673;10891.727706807393;11086.944565277123;11416.372099534605;11435;11556.88443115558;10719;10898.673039808818;11219.831702524305;11322.433878305887;11351.54593816238;9458.33791634579;9676.177524910461;9867.309288349747;10000;10335.483225838527;9033.819323613623;9671.129598336183;9686.273529485457;9696.6121355145;9708.660196893075 04:44:51 INFO - PROCESS | 5895 | __end_tp_report 04:44:51 INFO - PROCESS | 5895 | __start_cc_report 04:44:51 INFO - PROCESS | 5895 | _x_x_mozilla_cycle_collect,2329 04:44:51 INFO - PROCESS | 5895 | __end_cc_report 04:44:51 INFO - PROCESS | 5895 | __startTimestamp1476272691677__endTimestamp 04:44:51 INFO - PROCESS | 5895 | 04:44:51 INFO - PROCESS | 5895 | ------- Summary: start ------- 04:44:51 INFO - PROCESS | 5895 | Number of tests: 6 04:44:51 INFO - PROCESS | 5895 | 04:44:51 INFO - PROCESS | 5895 | [#0] dojo.html Cycles:165 Average:4698.05 Median:4796.83 stddev:506.42 (10.6%) stddev-sans-first:479.63 04:44:51 INFO - PROCESS | 5895 | Values: 2568.6 2599.7 2623.5 2637.4 2649.8 4662.0 4730.0 4745.1 4755.8 4773.5 4759.7 4776.7 4821.7 4860.6 4889.0 4351.2 4368.7 4401.3 4437.2 4438.5 4452.9 4517.2 4522.8 4523.4 4546.1 4278.7 4412.3 4430.9 4467.7 4551.9 4318.9 4365.9 4371.3 4380.7 4387.9 4354.1 4360.8 4361.0 4413.2 4428.0 4723.1 4748.5 4777.3 4792.2 4844.4 4886.2 4934.9 4938.0 5096.9 5122.6 5151.2 5167.6 5170.0 5224.8 5235.2 4784.9 4785.9 4786.3 4788.5 4851.6 5087.7 5168.4 5263.7 5264.9 5268.0 5001.4 5015.5 5049.9 5055.5 5122.4 5123.9 5134.9 5135.5 5140.6 5141.4 5034.2 5049.4 5083.9 5133.5 5150.4 4884.0 4929.0 4938.4 4998.8 5006.4 4174.7 4174.9 4175.0 4176.3 4178.1 3648.1 3660.9 3713.7 3724.7 3728.8 4382.1 4383.4 4413.0 4440.4 4444.4 5065.9 5112.2 5114.5 5135.9 5157.5 4256.8 4311.9 4379.7 4381.7 4441.1 4472.4 4510.0 4511.9 4520.3 4597.0 4755.0 4761.0 4762.7 4766.6 4826.7 5071.3 5080.6 5080.9 5083.1 5139.7 4632.5 4681.3 4704.5 4749.3 4753.5 4929.5 4956.2 4960.7 4962.5 4967.4 5029.7 5117.4 5159.3 5176.7 5245.3 5036.1 5038.3 5041.8 5093.4 5105.7 4995.1 5023.3 5037.1 5042.4 5098.1 4629.3 4664.1 4706.5 4949.3 4954.0 4894.9 4895.6 4896.2 4898.1 4901.4 4796.8 4819.5 4846.3 4877.8 4909.0 04:44:51 INFO - PROCESS | 5895 | 04:44:51 INFO - PROCESS | 5895 | [#1] ext.html Cycles:180 Average:42840.43 Median:19680.34 stddev:78581.82 (399.3%) stddev-sans-first:78738.12 04:44:51 INFO - PROCESS | 5895 | Values: 554.1 567.6 575.8 580.8 583.8 36865.6 38416.3 38578.4 38627.2 42174.2 38872.2 39274.6 39331.2 39333.4 39358.9 7438.2 7577.2 7580.1 7580.8 7583.2 7307.6 7389.0 7390.6 7391.2 7391.9 7388.7 7414.2 7425.4 7430.4 7432.7 7321.3 7330.0 7339.6 7342.8 7349.1 7505.9 7575.9 7577.2 7579.6 7587.6 35845.1 36108.3 36118.0 36146.0 36160.0 3011.0 3025.8 3037.3 3304.8 3578.7 27524.2 27900.0 28464.3 29743.4 29774.3 3184.5 3224.0 3226.9 3233.4 3275.4 175739.0 175778.0 175849.0 175928.0 176708.0 31140.7 32052.0 32126.5 51951.0 52255.0 33541.5 33765.5 33792.2 33860.0 33860.8 12112.9 12323.8 12343.8 12481.9 12486.3 9549.0 9554.8 9555.0 9577.7 9605.4 7792.5 7807.0 7848.3 7944.6 7948.3 3064.7 3071.6 3095.0 3110.2 3110.8 863.6 873.7 912.7 915.8 993.1 27130.0 27493.7 27940.6 28172.7 28453.9 909.8 970.5 975.6 996.1 1017.7 14215.6 14603.0 14940.6 14945.8 15123.8 376520.0 380607.0 380615.0 381155.0 381201.0 48051.5 48569.5 48702.5 48713.0 48743.3 1108.1 1136.5 1146.0 1152.2 1160.8 25289.4 26223.6 26912.8 27196.5 27275.3 41142.2 41602.6 41658.4 41782.0 41789.8 296819.0 298610.0 299174.0 299840.0 301450.0 25272.9 25743.9 25952.6 25984.0 25995.4 40161.0 40595.4 40903.8 41552.6 42133.4 34682.0 34779.8 34971.1 35256.6 35557.6 34846.7 34921.7 35347.0 35782.0 35838.1 34694.3 34703.5 34749.1 35764.0 37918.0 30579.0 33038.5 33048.7 33141.7 33246.0 24597.8 25571.9 25584.0 25983.5 26044.3 04:44:51 INFO - PROCESS | 5895 | 04:44:51 INFO - PROCESS | 5895 | [#2] jquery.html Cycles:180 Average:24072.14 Median:5269.56 stddev:65042.87 (1234.3%) stddev-sans-first:65200.92 04:44:51 INFO - PROCESS | 5895 | Values: 340.4 358.4 367.9 373.9 384.6 12194.5 13103.2 13223.6 16639.0 16666.7 14927.9 14964.9 15948.1 15957.4 15987.0 4891.4 5066.6 5116.5 5119.7 5123.2 3619.7 3834.5 5654.8 5933.8 6016.5 5888.9 6153.7 6157.6 6169.6 6171.1 6008.5 6009.9 6042.1 6042.2 6045.6 5224.9 5232.1 5307.0 5319.7 5334.3 20173.1 20189.0 20313.4 20381.1 20529.0 1875.4 1880.6 2332.9 2417.2 2424.7 12773.8 12857.9 13047.5 13359.7 13619.9 1699.9 1723.4 1734.3 1741.4 1746.5 66859.7 67916.7 68011.3 68394.0 68495.0 9081.7 9385.6 9534.9 9560.3 9655.9 12989.7 12990.7 12996.7 13011.7 13020.5 6955.3 7025.8 7032.3 7141.9 7489.7 6829.5 6881.4 6890.0 7293.2 7390.5 5737.5 5801.2 5899.7 5930.2 6118.3 1545.2 1641.4 1700.4 1732.3 1762.2 695.7 865.2 870.6 889.6 900.0 15430.2 16688.1 17285.8 17679.0 17848.8 839.6 846.4 851.7 868.1 898.7 9318.2 10083.1 10102.3 10118.8 10271.2 392748.0 392887.0 395662.0 398145.0 398173.0 66880.0 67146.7 67332.7 67984.7 68791.0 916.7 917.6 933.1 951.4 951.8 14275.4 14499.5 15678.9 15871.1 16935.7 38480.2 39023.8 39097.6 40051.0 40377.8 46047.3 48005.5 48360.3 48677.8 49098.3 7378.4 7456.0 7657.9 7733.8 8132.1 8201.5 10845.8 10933.5 11661.7 12177.2 8893.3 9285.6 9588.0 9790.3 10347.7 9194.7 9214.5 9299.0 9401.9 9635.7 9347.6 9427.9 9623.2 9896.9 9942.7 6456.5 6644.4 6680.3 6942.7 7563.7 8039.6 9768.5 10172.5 10363.7 10591.4 04:44:51 INFO - PROCESS | 5895 | 04:44:51 INFO - PROCESS | 5895 | [#3] mootools.html Cycles:180 Average:5137.64 Median:5376.54 stddev:2871.20 (53.4%) stddev-sans-first:2865.17 04:44:51 INFO - PROCESS | 5895 | Values: 1352.9 1374.7 1437.2 1598.8 1636.2 6912.9 7132.3 7401.6 8072.7 8094.4 7438.0 7652.2 7669.0 7907.7 7910.2 2172.7 2203.5 2204.8 2205.5 2209.0 1815.6 1876.0 2139.2 2169.0 2189.0 2094.1 2167.9 2168.6 2178.2 2183.4 2151.4 2171.1 2176.2 2177.8 2180.3 2150.0 2152.4 2157.9 2158.1 2160.0 7864.4 7941.4 7946.1 7951.1 7993.1 4448.0 4484.5 4519.5 4523.7 4531.1 2721.4 2908.2 2972.8 2980.0 2980.2 930.2 930.2 936.4 943.5 949.0 10731.9 10738.2 10739.8 10740.4 10743.4 4144.9 4151.1 4312.2 4332.8 4369.7 9153.4 9160.1 9165.2 9166.0 9166.6 4686.6 4696.6 4699.1 4699.6 4699.7 4125.9 4216.5 4269.7 4273.8 4277.8 3588.4 3595.2 3713.4 3714.2 3724.3 1095.0 1132.7 1168.4 1185.4 1198.7 770.5 770.6 830.5 830.8 868.6 5347.8 5365.4 5387.7 5464.8 5524.7 840.9 860.6 870.4 882.3 884.8 3607.3 3654.9 3658.4 3765.3 3895.2 9134.9 9431.9 9756.0 9781.4 9792.7 9543.1 9615.0 9625.3 9634.1 9635.3 7230.7 7260.9 7294.3 7346.8 7350.0 5051.2 5109.9 5222.8 5257.2 5434.0 8646.3 8748.3 8791.8 8798.8 8851.7 8822.7 8953.5 8964.4 9029.2 9040.4 6785.9 6870.0 6872.6 6873.8 6875.3 7202.4 7405.1 7465.6 7481.8 7488.7 5618.7 6703.6 6708.5 6734.6 6875.7 6538.4 6618.6 6626.9 6632.0 6632.5 6377.6 6441.1 6443.8 6456.6 6493.1 4474.1 4474.9 4543.8 4596.4 4645.9 4531.0 4636.1 4696.5 4716.4 4766.6 04:44:51 INFO - PROCESS | 5895 | 04:44:51 INFO - PROCESS | 5895 | [#4] prototype.html Cycles:180 Average:4150.15 Median:4759.86 stddev:1210.92 (25.4%) stddev-sans-first:1179.34 04:44:51 INFO - PROCESS | 5895 | Values: 300.8 306.8 310.5 310.9 314.6 4783.5 4791.8 4813.8 4818.6 4823.2 4731.3 4743.8 4759.3 4760.4 4760.8 3511.2 3634.5 3646.6 3728.6 3772.3 3760.6 3763.9 3768.4 3775.9 3785.9 3727.8 3734.3 3734.9 3735.7 3751.3 3549.5 3602.7 3671.0 3740.8 3766.2 3323.6 3328.3 3330.5 3333.4 3339.6 4649.7 4654.9 4659.5 4666.7 4669.9 4164.8 4265.5 4272.9 4291.3 4295.4 4963.5 4972.2 4974.3 4976.4 4984.9 3639.7 3643.2 3646.7 3648.6 3649.8 4899.2 5179.0 5207.7 5214.9 5215.7 3529.0 3548.8 3551.5 3567.3 3570.4 3586.1 3591.4 3598.9 3625.3 3633.7 4144.6 4149.4 4151.0 4159.9 4180.9 4775.6 4942.1 4976.8 4977.9 4980.4 1260.3 1270.7 1273.9 1274.2 1274.6 787.8 809.3 814.0 822.4 826.0 4026.6 4287.1 4391.2 4415.9 4529.0 5130.4 5189.8 5196.9 5197.2 5199.4 4438.9 4520.8 4529.1 4531.2 4532.3 2605.0 2699.7 2709.2 2714.4 2735.6 4812.0 4848.9 4848.9 4854.9 4859.4 5245.0 5245.7 5250.2 5272.8 5273.4 4721.8 4792.1 4792.3 4836.0 4839.8 5128.4 5143.9 5146.5 5148.1 5150.5 5053.1 5057.8 5058.6 5071.6 5071.7 4561.7 4834.0 4899.7 4909.0 4921.3 3653.3 3662.6 3667.9 3668.9 3673.7 5217.2 5217.2 5219.2 5221.4 5230.2 4900.4 4949.4 4998.5 5045.7 5048.9 5015.3 5034.4 5047.5 5053.5 5065.9 4969.3 4973.0 4979.9 5004.4 5021.2 4785.3 4891.9 4895.8 5034.6 5083.5 4715.2 4893.4 4910.4 4915.2 4925.0 04:44:51 INFO - PROCESS | 5895 | 04:44:51 INFO - PROCESS | 5895 | [#5] yui.html Cycles:180 Average:17149.59 Median:25660.51 stddev:24565.72 (95.7%) stddev-sans-first:24603.24 04:44:51 INFO - PROCESS | 5895 | Values: 608.2 614.4 619.2 625.2 643.4 12077.5 12265.8 13017.3 13185.9 13189.0 12869.9 12898.7 13009.9 13052.1 13088.5 599.3 752.7 770.4 773.2 774.0 615.5 748.9 768.0 773.6 775.4 808.1 809.6 809.8 811.5 812.3 621.2 803.4 803.6 804.1 804.2 468.2 561.7 576.5 578.8 578.9 12946.5 13002.7 13045.3 13049.9 13078.3 11921.3 12189.0 12364.1 12545.8 12974.5 11320.5 11489.7 11680.3 11779.5 11927.1 3919.5 3945.7 3988.5 4065.3 4109.5 60625.7 61707.7 63175.0 64317.4 64509.7 9632.0 9774.6 9814.8 9886.3 9904.2 18309.4 18341.7 18490.9 18598.8 18734.8 6282.5 6293.2 6373.0 6392.8 6420.8 3477.1 3489.1 3567.6 3597.6 3614.2 2989.3 3096.9 3115.4 3117.3 3119.2 523.7 525.1 526.2 532.6 535.4 470.7 471.6 493.7 522.0 568.8 7785.2 7810.6 7906.0 7974.5 8111.8 539.7 570.5 576.5 583.1 589.9 3567.7 3747.8 3882.8 4149.3 4191.5 95437.0 98399.0 99680.5 100003.5 100636.4 50799.0 73771.0 79167.0 82313.6 83253.0 49072.8 73327.6 77319.0 78412.2 80786.2 7674.8 7717.4 7765.7 7842.2 7967.6 32104.2 37027.0 43591.1 44182.3 44227.0 39748.4 62909.0 63287.7 64541.0 67010.0 10530.3 10854.9 11058.1 11243.7 11376.9 11580.8 11625.5 11915.0 12436.6 12739.1 11356.2 11873.9 11949.2 12076.0 12267.9 10891.7 11086.9 11416.4 11435.0 11556.9 10719.0 10898.7 11219.8 11322.4 11351.5 9458.3 9676.2 9867.3 10000.0 10335.5 9033.8 9671.1 9686.3 9696.6 9708.7 04:44:51 INFO - PROCESS | 5895 | -------- Summary: end -------- 04:44:51 INFO - PROCESS | 5895 | 04:44:52 INFO - TEST-INFO | 5895: exit 0 04:44:52 INFO - TEST-OK | dromaeo_css | took 1121933ms 04:44:52 INFO - TEST-START | kraken 04:44:52 INFO - operating with platform_type : linux_ 04:44:52 INFO - Initialising browser for kraken test... 04:44:52 INFO - TEST-INFO | started process 6210 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxSs_iU/profile http://localhost:55835/getInfo.html) 04:44:56 INFO - PROCESS | 6210 | __metrics Screen width/height:1600/1200 04:44:56 INFO - PROCESS | 6210 | colorDepth:24 04:44:56 INFO - PROCESS | 6210 | Browser inner width/height: 1024/697 04:44:56 INFO - PROCESS | 6210 | __metrics 04:44:57 INFO - PROCESS | 6210 | 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" 04:44:57 INFO - PROCESS | 6210 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:44:57 INFO - PROCESS | 6210 | console.error: PushService: 04:44:57 INFO - PROCESS | 6210 | stateChangeProcessEnqueue: Error transitioning state 04:44:57 INFO - PROCESS | 6210 | UnknownError 04:44:58 INFO - TEST-INFO | 6210: exit 0 04:44:58 INFO - Browser initialized. 04:44:58 INFO - Running cycle 1/1 for kraken test... 04:44:58 INFO - TEST-INFO | started process 6292 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxSs_iU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:45:10 INFO - PROCESS | 6292 | RSS: Main: 175112192 04:45:10 INFO - PROCESS | 6292 | 04:45:13 INFO - PROCESS | 6292 | Cycle 1(1): loaded http://localhost:55835/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55835/tests/kraken/driver.html?testName=audio-beat-detection) 04:45:14 INFO - PROCESS | 6292 | RSS: Main: 233213952 04:45:14 INFO - PROCESS | 6292 | 04:45:17 INFO - PROCESS | 6292 | Cycle 1(1): loaded http://localhost:55835/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55835/tests/kraken/driver.html?testName=audio-dft) 04:45:17 INFO - PROCESS | 6292 | RSS: Main: 218521600 04:45:17 INFO - PROCESS | 6292 | 04:45:21 INFO - PROCESS | 6292 | Cycle 1(1): loaded http://localhost:55835/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55835/tests/kraken/driver.html?testName=audio-fft) 04:45:21 INFO - PROCESS | 6292 | RSS: Main: 299974656 04:45:21 INFO - PROCESS | 6292 | 04:45:23 INFO - PROCESS | 6292 | Cycle 1(1): loaded http://localhost:55835/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55835/tests/kraken/driver.html?testName=audio-oscillator) 04:45:24 INFO - PROCESS | 6292 | RSS: Main: 208453632 04:45:24 INFO - PROCESS | 6292 | 04:45:26 INFO - PROCESS | 6292 | Cycle 1(1): loaded http://localhost:55835/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55835/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:45:27 INFO - PROCESS | 6292 | RSS: Main: 213647360 04:45:27 INFO - PROCESS | 6292 | 04:45:30 INFO - PROCESS | 6292 | Cycle 1(1): loaded http://localhost:55835/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55835/tests/kraken/driver.html?testName=imaging-darkroom) 04:45:31 INFO - PROCESS | 6292 | RSS: Main: 250257408 04:45:31 INFO - PROCESS | 6292 | 04:45:34 INFO - PROCESS | 6292 | Cycle 1(1): loaded http://localhost:55835/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55835/tests/kraken/driver.html?testName=imaging-desaturate) 04:45:35 INFO - PROCESS | 6292 | RSS: Main: 244023296 04:45:35 INFO - PROCESS | 6292 | 04:45:38 INFO - PROCESS | 6292 | Cycle 1(1): loaded http://localhost:55835/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55835/tests/kraken/driver.html?testName=json-parse-financial) 04:45:38 INFO - PROCESS | 6292 | RSS: Main: 246976512 04:45:38 INFO - PROCESS | 6292 | 04:45:40 INFO - PROCESS | 6292 | Cycle 1(1): loaded http://localhost:55835/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55835/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:45:41 INFO - PROCESS | 6292 | RSS: Main: 210243584 04:45:41 INFO - PROCESS | 6292 | 04:45:43 INFO - PROCESS | 6292 | Cycle 1(1): loaded http://localhost:55835/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55835/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:45:43 INFO - PROCESS | 6292 | RSS: Main: 217829376 04:45:43 INFO - PROCESS | 6292 | 04:45:45 INFO - PROCESS | 6292 | Cycle 1(1): loaded http://localhost:55835/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55835/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:45:46 INFO - PROCESS | 6292 | RSS: Main: 226836480 04:45:46 INFO - PROCESS | 6292 | 04:45:49 INFO - PROCESS | 6292 | Cycle 1(1): loaded http://localhost:55835/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55835/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:45:50 INFO - PROCESS | 6292 | RSS: Main: 235552768 04:45:50 INFO - PROCESS | 6292 | 04:45:53 INFO - PROCESS | 6292 | Cycle 1(1): loaded http://localhost:55835/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55835/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:45:53 INFO - PROCESS | 6292 | RSS: Main: 232357888 04:45:53 INFO - PROCESS | 6292 | 04:45:55 INFO - PROCESS | 6292 | Cycle 1(1): loaded http://localhost:55835/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55835/tests/kraken/driver.html?testName=ai-astar) 04:45:55 INFO - PROCESS | 6292 | RSS: Main: 283578368 04:45:55 INFO - PROCESS | 6292 | 04:45:55 INFO - PROCESS | 6292 | __start_tp_report 04:45:55 INFO - PROCESS | 6292 | _x_x_mozilla_page_load 04:45:55 INFO - PROCESS | 6292 | _x_x_mozilla_page_load_details 04:45:55 INFO - PROCESS | 6292 | |i|pagename|runs| 04:45:55 INFO - PROCESS | 6292 | |0;ai-astar;113;113;115;113;113;114;114;111;112;113 04:45:55 INFO - PROCESS | 6292 | |1;audio-beat-detection;161;138;128;169;133;131;132;133;172;126 04:45:55 INFO - PROCESS | 6292 | |2;audio-dft;161;160;162;162;164;163;161;161;160;161 04:45:55 INFO - PROCESS | 6292 | |3;audio-fft;77;77;76;122;76;76;77;77;118;77 04:45:55 INFO - PROCESS | 6292 | |4;audio-oscillator;83;84;124;84;84;84;115;84;84;113 04:45:55 INFO - PROCESS | 6292 | |5;imaging-gaussian-blur;117;118;117;117;117;117;116;117;117;118 04:45:55 INFO - PROCESS | 6292 | |6;imaging-darkroom;148;147;146;147;146;146;147;148;147;146 04:45:55 INFO - PROCESS | 6292 | |7;imaging-desaturate;95;96;95;95;96;96;96;96;95;95 04:45:55 INFO - PROCESS | 6292 | |8;json-parse-financial;65;64;75;65;65;65;65;65;65;66 04:45:55 INFO - PROCESS | 6292 | |9;json-stringify-tinderbox;66;65;65;67;66;66;66;65;67;67 04:45:55 INFO - PROCESS | 6292 | |10;stanford-crypto-aes;84;83;85;91;84;86;83;83;82;83 04:45:55 INFO - PROCESS | 6292 | |11;stanford-crypto-ccm;138;139;139;138;146;136;136;141;188;147 04:45:55 INFO - PROCESS | 6292 | |12;stanford-crypto-pbkdf2;177;174;174;176;179;174;173;173;176;172 04:45:55 INFO - PROCESS | 6292 | |13;stanford-crypto-sha256-iterative;69;69;69;77;70;70;72;70;69;71 04:45:55 INFO - PROCESS | 6292 | __end_tp_report 04:45:55 INFO - PROCESS | 6292 | __start_cc_report 04:45:55 INFO - PROCESS | 6292 | _x_x_mozilla_cycle_collect,1968 04:45:55 INFO - PROCESS | 6292 | __end_cc_report 04:45:55 INFO - PROCESS | 6292 | __startTimestamp1476272755735__endTimestamp 04:45:55 INFO - PROCESS | 6292 | 04:45:55 INFO - PROCESS | 6292 | ------- Summary: start ------- 04:45:55 INFO - PROCESS | 6292 | Number of tests: 14 04:45:55 INFO - PROCESS | 6292 | 04:45:55 INFO - PROCESS | 6292 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:1.10 (1.0%) stddev-sans-first:1.17 04:45:55 INFO - PROCESS | 6292 | Values: 113.0 113.0 115.0 113.0 113.0 114.0 114.0 111.0 112.0 113.0 04:45:55 INFO - PROCESS | 6292 | 04:45:55 INFO - PROCESS | 6292 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:135.50 stddev:17.76 (13.1%) stddev-sans-first:17.51 04:45:55 INFO - PROCESS | 6292 | Values: 161.0 138.0 128.0 169.0 133.0 131.0 132.0 133.0 172.0 126.0 04:45:55 INFO - PROCESS | 6292 | 04:45:55 INFO - PROCESS | 6292 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.27 (0.8%) stddev-sans-first:1.33 04:45:55 INFO - PROCESS | 6292 | Values: 161.0 160.0 162.0 162.0 164.0 163.0 161.0 161.0 160.0 161.0 04:45:55 INFO - PROCESS | 6292 | 04:45:55 INFO - PROCESS | 6292 | [#3] audio-fft Cycles:10 Average:85.30 Median:77.00 stddev:18.32 (23.8%) stddev-sans-first:19.18 04:45:55 INFO - PROCESS | 6292 | Values: 77.0 77.0 76.0 122.0 76.0 76.0 77.0 77.0 118.0 77.0 04:45:55 INFO - PROCESS | 6292 | 04:45:55 INFO - PROCESS | 6292 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:84.00 stddev:16.41 (19.5%) stddev-sans-first:16.92 04:45:55 INFO - PROCESS | 6292 | Values: 83.0 84.0 124.0 84.0 84.0 84.0 115.0 84.0 84.0 113.0 04:45:55 INFO - PROCESS | 6292 | 04:45:55 INFO - PROCESS | 6292 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 04:45:55 INFO - PROCESS | 6292 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 118.0 04:45:55 INFO - PROCESS | 6292 | 04:45:55 INFO - PROCESS | 6292 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 04:45:55 INFO - PROCESS | 6292 | Values: 148.0 147.0 146.0 147.0 146.0 146.0 147.0 148.0 147.0 146.0 04:45:55 INFO - PROCESS | 6292 | 04:45:55 INFO - PROCESS | 6292 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:45:55 INFO - PROCESS | 6292 | Values: 95.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 04:45:55 INFO - PROCESS | 6292 | 04:45:55 INFO - PROCESS | 6292 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:65.00 stddev:3.20 (4.9%) stddev-sans-first:3.37 04:45:55 INFO - PROCESS | 6292 | Values: 65.0 64.0 75.0 65.0 65.0 65.0 65.0 65.0 65.0 66.0 04:45:55 INFO - PROCESS | 6292 | 04:45:55 INFO - PROCESS | 6292 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 04:45:55 INFO - PROCESS | 6292 | Values: 66.0 65.0 65.0 67.0 66.0 66.0 66.0 65.0 67.0 67.0 04:45:55 INFO - PROCESS | 6292 | 04:45:55 INFO - PROCESS | 6292 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:2.59 (3.1%) stddev-sans-first:2.74 04:45:55 INFO - PROCESS | 6292 | Values: 84.0 83.0 85.0 91.0 84.0 86.0 83.0 83.0 82.0 83.0 04:45:55 INFO - PROCESS | 6292 | 04:45:55 INFO - PROCESS | 6292 | [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:140.00 stddev:15.64 (11.2%) stddev-sans-first:16.39 04:45:55 INFO - PROCESS | 6292 | Values: 138.0 139.0 139.0 138.0 146.0 136.0 136.0 141.0 188.0 147.0 04:45:55 INFO - PROCESS | 6292 | 04:45:55 INFO - PROCESS | 6292 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:175.00 stddev:2.15 (1.2%) stddev-sans-first:2.13 04:45:55 INFO - PROCESS | 6292 | Values: 177.0 174.0 174.0 176.0 179.0 174.0 173.0 173.0 176.0 172.0 04:45:55 INFO - PROCESS | 6292 | 04:45:55 INFO - PROCESS | 6292 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.00 stddev:2.46 (3.5%) stddev-sans-first:2.54 04:45:55 INFO - PROCESS | 6292 | Values: 69.0 69.0 69.0 77.0 70.0 70.0 72.0 70.0 69.0 71.0 04:45:55 INFO - PROCESS | 6292 | -------- Summary: end -------- 04:45:55 INFO - PROCESS | 6292 | 04:45:57 INFO - TEST-INFO | 6292: exit 0 04:45:57 INFO - TEST-OK | kraken | took 64366ms 04:45:57 INFO - SUITE-END | took 1186s 04:45:57 INFO - Completed test suite (00:19:46) 04:45:57 INFO - javascript benchmark 04:45:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2568.6275490053945, 2599.7010343810466, 2623.4884197581473, 2637.393399518111, 2649.8012649051316, 4661.997670500841, 4730.0, 4745.098431298055, 4755.833545825897, 4773.474917759044, 4759.714417134975, 4776.71339719617, 4821.662483626147, 4860.562549370556, 4888.975555122228, 4351.173277077345, 4368.737875727451, 4401.317795741666, 4437.156940181371, 4438.467383913935, 4452.910941781162, 4517.2094883395275, 4522.751248681321, 4523.411956445674, 4546.0680560485025, 4278.700490965633, 4412.316091005867, 4430.933535996963, 4467.7319360838455, 4551.931721024187, 4318.935215971763, 4365.869023929287, 4371.322445021026, 4380.693351465398, 4387.868363949086, 4354.107407981356, 4360.7819609019425, 4360.978195109036, 4413.227685155117, 4427.955720442818, 4723.126221648971, 4748.477667456577, 4777.307290442901, 4792.161371759928, 4844.37023186987, 4886.169351210303, 4934.876628084291, 4938.0, 5096.949030509684, 5122.641415100945, 5151.17581187012, 5167.612429067835, 5170.0, 5224.843254702327, 5235.188545775411, 4784.880377990543, 4785.904281914342, 4786.305985632064, 4788.497207793132, 4851.587615052689, 5087.669301495391, 5168.3539557555305, 5263.657862239019, 5264.894702105937, 5268.0, 5001.44984051754, 5015.4733752956145, 5049.949500505021, 5055.494450554988, 5122.385313762298, 5123.897522049613, 5134.87162820925, 5135.512126348066, 5140.640155189101, 5141.38303403594, 5034.194528875436, 5049.394072711299, 5083.8983220335385, 5133.512316329943, 5150.381954165449, 4883.95116048835, 4929.0, 4938.358013458227, 4998.775055122528, 5006.3992320921, 4174.749515029108, 4174.91650166995, 4174.979125104416, 4176.31090870003, 4178.101708132766, 3648.1062139775927, 3660.908477288089, 3713.6843368313457, 3724.7020238380865, 3728.7949162795762, 4382.05785756064, 4383.364412160219, 4413.029133590605, 4440.3561483585345, 4444.422225110715, 5065.924011139836, 5112.233165025276, 5114.462981386975, 5135.871603209875, 5157.4584668610005, 4256.787160641956, 4311.935320970188, 4379.715318504287, 4381.715188512737, 4441.133978874153, 4472.44094488189, 4510.0, 4511.932321015187, 4520.299353600197, 4597.034622729264, 4755.025219829927, 4760.952390476189, 4762.666613337172, 4766.571008609242, 4826.686265392738, 5071.264666623245, 5080.568151706999, 5080.872978175576, 5083.135866902561, 5139.743012849417, 4632.4672662644225, 4681.250999840009, 4704.482506924167, 4749.26386410107, 4753.453352864465, 4929.507049295042, 4956.231784073474, 4960.70235785854, 4962.503749625009, 4967.3542439482635, 5029.74851257443, 5117.43708192106, 5159.251908473326, 5176.741162941763, 5245.291885595549, 5036.118679231193, 5038.294638750504, 5041.8487445376695, 5093.439721630692, 5105.7191854448365, 4995.125852975787, 5023.321851549994, 5037.143685573388, 5042.445331013659, 5098.056859481007, 4629.259318509023, 4664.113818374498, 4706.529347065266, 4949.33184020167, 4953.9752301239705, 4894.877628059327, 4895.559399654048, 4896.1921282987905, 4898.093852637274, 4901.362822833009, 4796.832110876242, 4819.518048195152, 4846.273059041172, 4877.756112194447, 4909.018196360671], "value": 4664.66651034735, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.0636324611406, 567.5884983387045, 575.772569834915, 580.8170426315708, 583.7956715149696, 36865.63134368655, 38416.3108582399, 38578.42132368013, 38627.22745545088, 42174.15651686972, 38872.22255554894, 39274.607253927454, 39331.21337573247, 39333.409998849966, 39358.85129189658, 7438.181800002009, 7577.204393538682, 7580.090389153309, 7580.810479737996, 7583.203763604824, 7307.598082105482, 7389.0, 7390.556566605994, 7391.223921488247, 7391.926080739177, 7388.667509962038, 7414.184439711627, 7425.405967522613, 7430.442716796235, 7432.739854105107, 7321.304476074764, 7330.0, 7339.559626422379, 7342.816429589277, 7349.118105827281, 7505.887411688829, 7575.886361704579, 7577.204393538709, 7579.62101894903, 7587.582682952436, 35845.10387240314, 36108.277834443164, 36118.0, 36146.0, 36160.0, 3011.0, 3025.803322784012, 3037.2862377341307, 3304.7686661933676, 3578.6779189873037, 27524.174274771787, 27900.0, 28464.28839279014, 29743.405131897456, 29774.255643608867, 3184.538241954927, 3224.0489055728617, 3226.887058952949, 3233.369492948876, 3275.3776782411264, 175739.0, 175778.0, 175848.99999999872, 175928.0, 176708.0, 31140.68859311423, 32052.0, 32126.518102228485, 51951.0, 52255.0, 33541.49687754686, 33765.49351759726, 33792.1551961198, 33860.0, 33860.830695846365, 12112.939435302944, 12323.75352492963, 12343.814842777365, 12481.93759031199, 12486.313252771184, 9549.045095490395, 9554.808903821884, 9555.0, 9577.712668619952, 9605.423674579548, 7792.493487923267, 7806.960965195138, 7848.293653571091, 7944.642491087915, 7948.324392426708, 3064.7088526589937, 3071.6006919100373, 3094.9535756963664, 3110.1602567307154, 3110.751139908802, 863.6027427383474, 873.6636394987976, 912.6623149434752, 915.8076803871129, 993.0665174735725, 27130.0, 27493.725062749116, 27940.58089128665, 28172.71827281742, 28453.85773071163, 909.836229478687, 970.5050424283667, 975.6341371985505, 996.138340335619, 1017.6743442098606, 14215.64460888486, 14603.0, 14940.551783446514, 14945.775813362809, 15123.773143402857, 376520.0, 380607.0, 380615.0, 381155.0, 381201.0, 48051.5194848054, 48569.514304857206, 48702.512974869795, 48713.0, 48743.268850967266, 1108.1245815805585, 1136.471540733563, 1145.9541618335172, 1152.2395219155317, 1160.7562411893598, 25289.367765806, 26223.60664590071, 26912.77849935074, 27196.456070878867, 27275.31811704723, 41142.177156456106, 41602.58397415987, 41658.375124373764, 41782.0, 41789.79105104455, 296819.0, 298610.0, 299174.0, 299840.0, 301450.0, 25272.873635631706, 25743.871280644227, 25952.610710838973, 25984.0, 25995.350116247246, 40161.0, 40595.36432372421, 40903.7954810236, 41552.58447415608, 42133.367999480644, 34682.0, 34779.82610086934, 34971.12572185614, 35256.64743352534, 35557.64442355543, 34846.65153348434, 34921.650783492856, 35347.0, 35782.0, 35838.10404739902, 34694.30611387808, 34703.47944780881, 34749.13127171841, 35764.0, 37918.0, 30579.0, 33038.50442243416, 33048.66951330456, 33141.66858331482, 33246.0, 24597.754022460264, 25571.872140639178, 25584.0, 25983.480330392907, 26044.34889127787], "value": 15808.849686651185, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.4008944258105, 358.4211498430035, 367.8767612849695, 373.85232833030943, 384.58464857953413, 12194.451249693762, 13103.213807171565, 13223.603291901234, 16639.0, 16666.66666666666, 14927.92536037321, 14964.850351496481, 15948.122853243067, 15957.441489547868, 15987.0, 4891.388576427947, 5066.645334826564, 5116.488351164891, 5119.718415487147, 5123.205903085028, 3619.7104231661538, 3834.5015148030716, 5654.802081927133, 5933.762649494015, 6016.4885984691355, 5888.852778680524, 6153.661548614825, 6157.568970172089, 6169.598976066542, 6171.13604095427, 6008.48927841134, 6009.9399006010035, 6042.093685947099, 6042.244719410074, 6045.6070355426755, 5224.895502089975, 5232.136697444917, 5306.973465132688, 5319.734013299359, 5334.253204551327, 20173.092210850547, 20189.0, 20313.390598282076, 20381.082851271727, 20529.0, 1875.409246087478, 1880.5674694820132, 2332.941676458085, 2417.1781594258036, 2424.7454017328105, 12773.808392874114, 12857.871421285761, 13047.478100875953, 13359.666008349772, 13619.931900340434, 1699.8555122814575, 1723.388197189992, 1734.332282071399, 1741.3556983915905, 1746.5197070805502, 66859.66570167166, 67916.6604166981, 68011.319886801, 68394.0, 68495.0, 9081.727548173565, 9385.577649005674, 9534.856977145348, 9560.28297877662, 9655.9034409655, 12989.740205195843, 12990.675233119247, 12996.660601091706, 13011.739765204642, 13020.544280950122, 6955.33924277203, 7025.789226323219, 7032.26161253061, 7141.857162856713, 7489.667098141274, 6829.521933464709, 6881.449484041264, 6889.965550172217, 7293.16128645202, 7390.519616225036, 5737.540996720252, 5801.158831969341, 5899.705014749331, 5930.169776231331, 6118.265808103056, 1545.2273863068465, 1641.3762770147507, 1700.3846345971376, 1732.289761197928, 1762.171779263744, 695.7356204642203, 865.1910463716446, 870.6430363550913, 889.564113584339, 899.9595018224196, 15430.228488575527, 16688.082155481567, 17285.827141728674, 17678.994570922972, 17848.821511784718, 839.5634270179472, 846.3736834742369, 851.7104184577273, 868.1405408645521, 898.7034278688018, 9318.207952323994, 10083.092521673085, 10102.343347682377, 10118.797624047626, 10271.229657775548, 392748.0, 392887.0, 395662.0, 398145.0, 398173.0, 66880.0, 67146.66426667836, 67332.663336683, 67984.6600766993, 68791.0, 916.6608354908726, 917.559571405729, 933.0529512544772, 951.3863558005048, 951.7668171298076, 14275.42898284057, 14499.49251776225, 15678.9216053919, 15871.127088010271, 16935.66128677395, 38480.23039539137, 39023.80488097541, 39097.60902391053, 40051.0, 40377.79811101043, 46047.30929036134, 48005.51994480011, 48360.27459588179, 48677.75661121814, 49098.26352604642, 7378.372838308589, 7455.962720186364, 7657.923420765944, 7733.845323093619, 8132.064812546633, 8201.548914809742, 10845.783084338427, 10933.507992140214, 11661.708457288636, 12177.208481448677, 8893.28853691716, 9285.582148803454, 9587.952060239653, 9790.314677972758, 10347.689569312932, 9194.724158275263, 9214.493202873906, 9298.95350523243, 9401.905980940102, 9635.710928672152, 9347.626094956126, 9427.905720942703, 9623.212608287191, 9896.851547226941, 9942.652007179713, 6456.451201647913, 6644.402003819486, 6680.298568650416, 6942.652867356511, 7563.659635316534, 8039.557824319719, 9768.511574421393, 10172.50542649511, 10363.689089327332, 10591.417472039111], "value": 8182.6272665355245, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.9323533823313, 1374.7456720506705, 1437.195170704405, 1598.7921570195872, 1636.199672162185, 6912.861742765142, 7132.286771322865, 7401.592912389817, 8072.71745488908, 8094.433389662726, 7437.962810185942, 7652.1582625911105, 7669.0, 7907.723229686962, 7910.248526389983, 2172.663237198237, 2203.5152266501345, 2204.7684993075654, 2205.52581195043, 2208.9558208835815, 1815.5824160443105, 1875.990620046898, 2139.1764170794277, 2168.9566208675815, 2188.9671654925187, 2094.099537199004, 2167.9349619511363, 2168.577127460146, 2178.1505212966954, 2183.3995651195887, 2151.440625437382, 2171.0989939175224, 2176.1948079210792, 2177.7604463509, 2180.3132013415884, 2149.9785002150093, 2152.4080877758583, 2157.9352619421284, 2158.082814803718, 2160.0495781855934, 7864.370850331959, 7941.364690824778, 7946.125926148119, 7951.085625153066, 7993.08079570851, 4448.043670610802, 4484.506704262529, 4519.4802597701355, 4523.683342166049, 4531.093781243764, 2721.360480287131, 2908.2293192304055, 2972.821630702165, 2979.9851000744857, 2980.210244285266, 930.16285343191, 930.1767935377239, 936.4194199596226, 943.528235882059, 948.9762755931088, 10731.946340268249, 10738.248322617419, 10739.78520429595, 10740.355578665305, 10743.355398676027, 4144.91710165795, 4151.12826306473, 4312.159128969884, 4332.783360831946, 4369.694121411534, 9153.35926485153, 9160.083991600786, 9165.175134237817, 9165.954170229106, 9166.633334666672, 4686.625069994392, 4696.600788932979, 4699.107169637758, 4699.553542413465, 4699.694519856198, 4125.886010777073, 4216.51510076339, 4269.679774016961, 4273.803335066186, 4277.7647229402055, 3588.372034893883, 3595.173110184672, 3713.442983552489, 3714.201446688975, 3724.329620668306, 1094.9835752463719, 1132.7338075552238, 1168.3584563688032, 1185.3776767197292, 1198.7003249187703, 770.4529783853415, 770.5915864591775, 830.5058490198322, 830.8462934357163, 868.5874209750318, 5347.839564813062, 5365.356157261075, 5387.730613469311, 5464.781408743605, 5524.696141712245, 840.932725381968, 860.580941594245, 870.4298684361753, 882.3177540277485, 884.7566919097171, 3607.2965771674794, 3654.8720794772057, 3658.414653655402, 3765.2657731742597, 3895.2209558088493, 9134.862977055349, 9431.905680943102, 9756.0, 9781.364211326241, 9792.657256995972, 9543.093406126407, 9615.0, 9625.32622716417, 9634.13292803651, 9635.277354198462, 7230.74692385764, 7260.92739072613, 7294.343509084102, 7346.77959661211, 7350.007748953823, 5051.166557517969, 5109.8722531937, 5222.7910883565755, 5257.185136303879, 5434.0, 8646.308295336485, 8748.343874209333, 8791.824163516565, 8798.824023519623, 8851.734447966572, 8822.735317940473, 8953.522668759582, 8964.372493925623, 9029.23251523628, 9040.41237319572, 6785.864282714417, 6870.0, 6872.62200578973, 6873.828154296182, 6875.312468753084, 7202.3877970373105, 7405.074365704287, 7465.552066876005, 7481.812954676177, 7488.700451981859, 5618.747156377891, 6703.597784132968, 6708.463322934056, 6734.595924244365, 6875.690593923186, 6538.378854008862, 6618.63597502142, 6626.900596491153, 6631.966840165961, 6632.50256230775, 6377.585456945284, 6441.098246245623, 6443.806685799434, 6456.644884531396, 6493.058506516623, 4474.082813023388, 4474.932876006797, 4543.750093744744, 4596.4254468191475, 4645.907081858411, 4531.0, 4636.072785442992, 4696.530346965276, 4716.3868697069165, 4766.642501812308], "value": 4136.448363070924, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.7864416264452, 306.7760534809589, 310.5124953822499, 310.85389866762625, 314.59103165884346, 4783.545563171502, 4791.808327666898, 4813.783379747915, 4818.638602104847, 4823.180059389903, 4731.33761273422, 4743.76281185941, 4759.309900064489, 4760.404949381327, 4760.762201827524, 3511.2275299434145, 3634.4735211211223, 3646.562412510489, 3728.571214310362, 3772.302124107035, 3760.6427389397963, 3763.9059023524496, 3768.3970564709653, 3775.924481510368, 3785.9432108518395, 3727.7949712765785, 3734.253149370123, 3734.9253014939686, 3735.7384983051197, 3751.268502641986, 3549.538559987198, 3602.7117830573493, 3670.9816450917706, 3740.8129593520216, 3766.2090960898245, 3323.6344002159744, 3328.3176948725454, 3330.5170750241323, 3333.4333163362285, 3339.6159441664277, 4649.651276154302, 4654.86035418938, 4659.510751371091, 4666.719996800169, 4669.859904202879, 4164.8125834337225, 4265.466816647919, 4272.889048847322, 4291.270484017693, 4295.441592592974, 4963.503649635044, 4972.154733695281, 4974.303597496353, 4976.402831660188, 4984.90030199394, 3639.70882329413, 3643.2167084076787, 3646.690031347339, 3648.616895226016, 3649.7810131392202, 4899.216125419915, 5179.0, 5207.739613019372, 5214.9217761733225, 5215.687058776448, 3529.0061115469675, 3548.8288864674596, 3551.5205447264807, 3567.340042092221, 3570.3573356795505, 3586.085548185248, 3591.40741777609, 3598.884345852794, 3625.329314076904, 3633.709303255733, 4144.564820693844, 4149.356849688304, 4150.958490415118, 4159.91680166395, 4180.916381672349, 4775.594074503706, 4942.135126352874, 4976.825811096594, 4977.925331120036, 4980.402351717817, 1260.3068312428127, 1270.707737220426, 1273.9490420383265, 1274.222724138275, 1274.6176147155816, 787.7872974296907, 809.3484744780391, 813.9511629302261, 822.3791037766448, 825.9628316725762, 4026.617471340218, 4287.121140166259, 4391.165678521071, 4415.867523974286, 4529.0, 5130.384353877558, 5189.76646050921, 5196.8960620787375, 5197.168453047494, 5199.402068762065, 4438.889027774267, 4520.773961301922, 4529.139463501924, 4531.207038768268, 4532.27483602622, 2604.9869750651123, 2699.743524365182, 2709.227870057024, 2714.4164004739077, 2735.603337516049, 4812.013537224861, 4848.878778030577, 4848.927266091011, 4854.902901941941, 4859.392575928009, 5244.973775131176, 5245.737713114329, 5250.159974404077, 5272.841814745564, 5273.393559740679, 4721.787519561628, 4792.076833131787, 4792.305115758196, 4835.99999999993, 4839.758012099452, 5128.410232823124, 5143.871403214949, 5146.485351464824, 5148.124818780741, 5150.536451719363, 5053.115704751727, 5057.799857062189, 5058.595312375075, 5071.594272458268, 5071.721055341992, 4561.749103799323, 4833.993892534559, 4899.730514821719, 4909.0, 4921.3356196912955, 3653.2693461307313, 3662.633736626316, 3667.889963301105, 3668.871589494355, 3673.669369756735, 5217.165253559564, 5217.217417387422, 5219.217117432264, 5221.433569929082, 5230.241614965885, 4900.409276944066, 4949.430815456125, 4998.4501704813165, 5045.6720313180995, 5048.924266136084, 5015.297858299914, 5034.4462109167225, 5047.4952504749235, 5053.469385714447, 5065.898682026265, 4969.304297398295, 4973.030259099441, 4979.900401992012, 5004.449510553909, 5021.171506701354, 4785.306130610972, 4891.902161956812, 4895.8041678332465, 5034.572061374824, 5083.517065878736, 4715.204260570274, 4893.363862697826, 4910.435299940553, 4915.21356582945, 4925.0396172747405], "value": 3766.189730984241, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.1637748096367, 614.4377993399012, 619.2043224456572, 625.2028663454093, 643.4241353988177, 12077.456514456848, 12265.816012759815, 13017.349132543382, 13185.868141318584, 13189.010824188188, 12869.871301286985, 12898.677533061678, 13009.869901300985, 13052.086353955227, 13088.541901033466, 599.3048064245476, 752.6801109528456, 770.4067867741863, 773.1611201846003, 774.0131332551015, 615.5045188623156, 748.8988986486836, 767.9731209407672, 773.5668025905483, 775.4300589067032, 808.0505406147782, 809.5587904592012, 809.8015986083418, 811.4887620798888, 812.2851890336525, 621.189347900989, 803.4175222963335, 803.586153131138, 804.111456840189, 804.2480280937342, 468.1736734663322, 561.6826493031424, 576.5474102829259, 578.7627072900133, 578.8552861784553, 12946.546870859569, 13002.739945201138, 13045.282509461977, 13049.934750326187, 13078.280694561796, 11921.344326062062, 12189.0, 12364.134510584263, 12545.811812822723, 12974.481020759253, 11320.490577924013, 11489.655310340702, 11680.299182049104, 11779.528818847322, 11927.105467090003, 3919.4904662393706, 3945.6646185074305, 3988.4615576897327, 4065.26825171469, 4109.547949725527, 60625.69687151536, 61707.691461542854, 63175.0, 64317.35682643207, 64509.67745161244, 9632.0, 9774.609015639295, 9814.754631134136, 9886.258530610234, 9904.158146557624, 18309.3591724289, 18341.7248741269, 18490.907545462454, 18598.81401185998, 18734.81265187358, 6282.4974002079725, 6293.1504246927, 6373.0, 6392.840178995562, 6420.807375778734, 3477.0959550517045, 3489.092835862694, 3567.554055743032, 3597.604263531062, 3614.150674591469, 2989.342344684166, 3096.9380612387627, 3115.439220940207, 3117.2986078132694, 3119.1890108571934, 523.677938068093, 525.0863497514374, 526.2317017154996, 532.6351449257271, 535.3816342124852, 470.6587723900145, 471.5590922487485, 493.6692416081234, 522.0212102308172, 568.8321945026228, 7785.221477852283, 7810.648520816577, 7906.0, 7974.481658692166, 8111.837763244702, 539.6600141910571, 570.492261886921, 576.533008263308, 583.1107560969471, 589.8643312038255, 3567.696745776638, 3747.793871337048, 3882.786446745456, 4149.315362965077, 4191.455110835633, 95437.0, 98399.0, 99680.50159749154, 100003.49998250107, 100636.43397309624, 50799.0, 73771.0, 79167.0, 82313.58843205865, 83253.0, 49072.754636227306, 73327.63336183285, 77319.0, 78412.21587784277, 80786.19213807904, 7674.769756907302, 7717.421193410404, 7765.689372425039, 7842.176571460142, 7967.601619919097, 32104.197395065312, 37027.0, 43591.12817743564, 44182.33726494169, 44227.0, 39748.40377394284, 62909.0, 63287.6835615819, 64541.0, 67010.0, 10530.31552949056, 10854.861297339312, 11058.11535077208, 11243.718907027389, 11376.94311528437, 11580.768384632429, 11625.47685354178, 11915.0, 12436.564720234748, 12739.108262421913, 11356.205065645325, 11873.881261187278, 11949.163558551165, 12076.033917286772, 12267.877321226673, 10891.727706807393, 11086.944565277123, 11416.372099534605, 11435.0, 11556.88443115558, 10719.0, 10898.673039808818, 11219.831702524305, 11322.433878305887, 11351.54593816238, 9458.33791634579, 9676.177524910461, 9867.309288349747, 10000.0, 10335.483225838527, 9033.819323613623, 9671.129598336183, 9686.273529485457, 9696.6121355145, 9708.660196893075], "value": 6390.236768002548, "unit": "score"}], "name": "dromaeo_css", "value": 6258.222312955332, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 115.0, 113.0, 113.0, 114.0, 114.0, 111.0, 112.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 138.0, 128.0, 169.0, 133.0, 131.0, 132.0, 133.0, 172.0, 126.0], "value": 142.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 162.0, 164.0, 163.0, 161.0, 161.0, 160.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 122.0, 76.0, 76.0, 77.0, 77.0, 118.0, 77.0], "value": 85.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 124.0, 84.0, 84.0, 84.0, 115.0, 84.0, 84.0, 113.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 148.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 75.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 67.0, 66.0, 66.0, 66.0, 65.0, 67.0, 67.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 85.0, 91.0, 84.0, 86.0, 83.0, 83.0, 82.0, 83.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 139.0, 139.0, 138.0, 146.0, 136.0, 136.0, 141.0, 188.0, 147.0], "value": 144.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 174.0, 174.0, 176.0, 179.0, 174.0, 173.0, 173.0, 176.0, 172.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 77.0, 70.0, 70.0, 72.0, 70.0, 69.0, 71.0], "value": 70.6, "unit": "score"}], "name": "kraken", "value": 1562.1, "alertThreshold": 2.0}]} 04:45:57 INFO - Return code: 0 04:45:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:45:57 INFO - # TBPL SUCCESS # 04:45:57 INFO - Running post-action listener: _resource_record_post_action 04:45:57 INFO - [mozharness: 2016-10-12 11:45:57.543970Z] Finished run-tests step (success) 04:45:57 INFO - Running post-run listener: _resource_record_post_run 04:45:57 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8192; Write bytes: 406994944; Read time: 12; Write time: 220516 04:45:57 INFO - TinderboxPrint: CPU usage
13.0% 04:45:57 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 12 04:45:57 INFO - TinderboxPrint: I/O write bytes / time
406,994,944 / 220,516 04:45:57 INFO - TinderboxPrint: CPU idle
8,346.9 (87.0%) 04:45:57 INFO - TinderboxPrint: CPU user
1,204.0 (12.5%) 04:45:57 INFO - TinderboxPrint: Swap in / out
0 / 0 04:45:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110563328; Read time: 0; Write time: 57664 04:45:57 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295383040; Read time: 4; Write time: 162820 04:45:58 INFO - Running post-run listener: _upload_blobber_files 04:45:58 INFO - Blob upload gear active. 04:45:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:45:58 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 04:45:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:45:58 INFO - (blobuploader) - INFO - Open directory for files ... 04:45:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:45:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:45:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:45:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:45:59 INFO - (blobuploader) - INFO - Done attempting. 04:45:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:45:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:46:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:02 INFO - (blobuploader) - INFO - Done attempting. 04:46:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:46:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:46:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:03 INFO - (blobuploader) - INFO - Done attempting. 04:46:03 INFO - (blobuploader) - INFO - Iteration through files over. 04:46:03 INFO - Return code: 0 04:46:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:46:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:46:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd61e0a425cf7f39d889e1f1af2d9aca9d1a1f28b858371bf1e3f85e5f6225829b56543c18bd891bfc9aa8c4835dfcce174909b4eba7b164766c80c5de1f5866", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/711a9984a7dc8a1c7380d8e48db1a6bff0d9ff41e00f7fdfba584678659e58782dab6e98607ddc5b0b745173dea36ce0e0180e82bf15473239bbf79b98c62f1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8c3cea224db7d0fbb81179ff15142573f5e9475a6dd260e906fbe6ecc4a8a06d3c6ae29f33e09224055dd2b009267e6b56104b2c8d3f778141916ec34d118a3"} 04:46:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:46:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:46:03 INFO - Contents: 04:46:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd61e0a425cf7f39d889e1f1af2d9aca9d1a1f28b858371bf1e3f85e5f6225829b56543c18bd891bfc9aa8c4835dfcce174909b4eba7b164766c80c5de1f5866", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/711a9984a7dc8a1c7380d8e48db1a6bff0d9ff41e00f7fdfba584678659e58782dab6e98607ddc5b0b745173dea36ce0e0180e82bf15473239bbf79b98c62f1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8c3cea224db7d0fbb81179ff15142573f5e9475a6dd260e906fbe6ecc4a8a06d3c6ae29f33e09224055dd2b009267e6b56104b2c8d3f778141916ec34d118a3"} 04:46:03 INFO - Running post-run listener: copy_logs_to_upload_dir 04:46:03 INFO - Copying logs to upload dir... 04:46:03 INFO - mkdir: /builds/slave/test/build/upload/logs 04:46:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.933105 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-12 04:46:02.783487) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 04:46:02.787176) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331 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-Non-PGO/sha512/bd61e0a425cf7f39d889e1f1af2d9aca9d1a1f28b858371bf1e3f85e5f6225829b56543c18bd891bfc9aa8c4835dfcce174909b4eba7b164766c80c5de1f5866", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/711a9984a7dc8a1c7380d8e48db1a6bff0d9ff41e00f7fdfba584678659e58782dab6e98607ddc5b0b745173dea36ce0e0180e82bf15473239bbf79b98c62f1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8c3cea224db7d0fbb81179ff15142573f5e9475a6dd260e906fbe6ecc4a8a06d3c6ae29f33e09224055dd2b009267e6b56104b2c8d3f778141916ec34d118a3"} build_url:https://queue.taskcluster.net/v1/task/d8F0IIknSh2rAc6bVY6TPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011352 build_url: 'https://queue.taskcluster.net/v1/task/d8F0IIknSh2rAc6bVY6TPA/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-Non-PGO/sha512/bd61e0a425cf7f39d889e1f1af2d9aca9d1a1f28b858371bf1e3f85e5f6225829b56543c18bd891bfc9aa8c4835dfcce174909b4eba7b164766c80c5de1f5866", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/711a9984a7dc8a1c7380d8e48db1a6bff0d9ff41e00f7fdfba584678659e58782dab6e98607ddc5b0b745173dea36ce0e0180e82bf15473239bbf79b98c62f1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8c3cea224db7d0fbb81179ff15142573f5e9475a6dd260e906fbe6ecc4a8a06d3c6ae29f33e09224055dd2b009267e6b56104b2c8d3f778141916ec34d118a3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 04:46:02.818016) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:46:02.818354) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1476270208.203731-1239392331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:46:02.903829) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 04:46:02.904564) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 04:46:02.905269) ========= ========= Total master_lag: 0.19 =========